[46.980051] Initializing watchdogs
[46.980229]   /dev/watchdog0
[46.990753] [001/165] (960s left) i915_module_load (load)
[47.102788] Starting subtest: load
[48.997336] Subtest load: SUCCESS (1.896s)
[49.036081] [002/165] (958s left) core_auth (basic-auth)
[49.187294] Starting subtest: basic-auth
[49.194105] Subtest basic-auth: SUCCESS (0.002s)
[49.330496] [003/165] (958s left) debugfs_test (read_all_entries)
[49.543029] Starting subtest: read_all_entries
[49.742369] Subtest read_all_entries: SUCCESS (0.200s)
[49.923101] [004/165] (957s left) debugfs_test (basic-hwmon)
[50.063767] Starting subtest: basic-hwmon
[50.067993] Subtest basic-hwmon: SKIP (0.000s)
[50.302294] [005/165] (957s left) fbdev (eof)
[50.414964] Starting subtest: eof
[50.418795] Subtest eof: SUCCESS (0.002s)
[50.474670] [006/165] (957s left) fbdev (info)
[50.596342] Starting subtest: info
[50.597608] Subtest info: SUCCESS (0.000s)
[50.655726] [007/165] (957s left) fbdev (nullptr)
[50.766659] Starting subtest: nullptr
[50.767757] Subtest nullptr: SUCCESS (0.000s)
[50.825634] [008/165] (956s left) fbdev (read)
[50.932645] Starting subtest: read
[52.529932] Subtest read: SUCCESS (1.597s)
[52.592579] [009/165] (955s left) fbdev (write)
[52.701628] Starting subtest: write
[53.549535] Subtest write: SUCCESS (0.850s)
[53.608087] [010/165] (954s left) gem_basic (bad-close)
[53.710888] Starting subtest: bad-close
[53.713822] Subtest bad-close: SUCCESS (0.000s)
[53.791285] [011/165] (954s left) gem_basic (create-close)
[53.893952] Starting subtest: create-close
[53.896241] Subtest create-close: SUCCESS (0.000s)
[53.973828] [012/165] (953s left) gem_basic (create-fd-close)
[54.077601] Starting subtest: create-fd-close
[54.080110] Subtest create-fd-close: SUCCESS (0.000s)
[54.157648] [013/165] (953s left) gem_busy (busy@all-engines)
[54.283974] Starting subtest: busy
[54.285715] Starting dynamic subtest: all-engines
[54.364977] Dynamic subtest all-engines: SUCCESS (0.078s)
[54.366104] Subtest busy: SUCCESS (0.079s)
[54.709901] [014/165] (953s left) gem_close_race (basic-process)
[54.836505] Starting subtest: basic-process
[54.916830] Subtest basic-process: SUCCESS (0.080s)
[55.110679] [015/165] (952s left) gem_close_race (basic-threads)
[55.235543] Starting subtest: basic-threads
[56.395347] Subtest basic-threads: SUCCESS (1.160s)
[56.574403] [016/165] (951s left) gem_ctx_create (basic)
[56.712163] Starting subtest: basic
[56.715596] Subtest basic: SUCCESS (0.000s)
[56.907309] [017/165] (951s left) gem_ctx_create (basic-files)
[57.031601] Starting subtest: basic-files
[59.061231] Subtest basic-files: SUCCESS (2.030s)
[59.259091] [018/165] (948s left) gem_ctx_exec (basic)
[59.365603] Starting subtest: basic
[59.370528] Subtest basic: SUCCESS (0.005s)
[59.458475] [019/165] (948s left) gem_exec_basic (basic)
[59.570129] Starting subtest: basic
[59.573613] Starting dynamic subtest: rcs0-smem
[59.574729] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[59.586456] Starting dynamic subtest: bcs0-smem
[59.587520] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[59.596564] Starting dynamic subtest: vcs0-smem
[59.597685] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[59.606435] Starting dynamic subtest: vecs0-smem
[59.607956] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[59.609269] Subtest basic: SUCCESS (0.009s)
[59.793220] [020/165] (948s left) gem_exec_create (basic)
[59.913250] Starting subtest: basic
[59.915912] Starting dynamic subtest: smem
[61.957696] Dynamic subtest smem: SUCCESS (2.044s)
[61.958978] Subtest basic: SUCCESS (2.045s)
[62.142801] [021/165] (945s left) gem_exec_fence (basic-busy)
[62.398336] Starting subtest: basic-busy
[62.401140] Starting dynamic subtest: rcs0
[62.409372] Dynamic subtest rcs0: SUCCESS (0.013s)
[62.421923] Starting dynamic subtest: bcs0
[62.427103] Dynamic subtest bcs0: SUCCESS (0.017s)
[62.439185] Starting dynamic subtest: vcs0
[62.443762] Dynamic subtest vcs0: SUCCESS (0.016s)
[62.455114] Starting dynamic subtest: vecs0
[62.464233] Dynamic subtest vecs0: SUCCESS (0.021s)
[62.465406] Subtest basic-busy: SUCCESS (0.070s)
[63.109892] [022/165] (944s left) gem_exec_fence (basic-wait)
[63.365227] Starting subtest: basic-wait
[63.366368] Starting dynamic subtest: rcs0
[63.380430] Dynamic subtest rcs0: SUCCESS (0.019s)
[63.393060] Starting dynamic subtest: bcs0
[63.398669] Dynamic subtest bcs0: SUCCESS (0.020s)
[63.411432] Starting dynamic subtest: vcs0
[63.423766] Dynamic subtest vcs0: SUCCESS (0.023s)
[63.436407] Starting dynamic subtest: vecs0
[63.446421] Dynamic subtest vecs0: SUCCESS (0.024s)
[63.447517] Subtest basic-wait: SUCCESS (0.087s)
[64.042859] [023/165] (944s left) gem_exec_fence (basic-await)
[64.303154] Starting subtest: basic-await
[64.304194] Starting dynamic subtest: rcs0
[64.414572] Dynamic subtest rcs0: SUCCESS (0.111s)
[64.429123] Starting dynamic subtest: bcs0
[64.523585] Dynamic subtest bcs0: SUCCESS (0.109s)
[64.534820] Starting dynamic subtest: vcs0
[64.642631] Dynamic subtest vcs0: SUCCESS (0.116s)
[64.653462] Starting dynamic subtest: vecs0
[64.753745] Dynamic subtest vecs0: SUCCESS (0.112s)
[64.755450] Subtest basic-await: SUCCESS (0.453s)
[65.359881] [024/165] (942s left) gem_exec_fence (nb-await)
[65.608960] Starting subtest: nb-await
[65.610070] Starting dynamic subtest: rcs0
[65.674459] Dynamic subtest rcs0: SUCCESS (0.066s)
[65.686918] Starting dynamic subtest: bcs0
[65.742711] Dynamic subtest bcs0: SUCCESS (0.065s)
[65.753240] Starting dynamic subtest: vcs0
[65.810943] Dynamic subtest vcs0: SUCCESS (0.067s)
[65.824809] Starting dynamic subtest: vecs0
[65.873591] Dynamic subtest vecs0: SUCCESS (0.063s)
[65.875521] Subtest nb-await: SUCCESS (0.266s)
[66.459839] [025/165] (941s left) gem_exec_gttfill (basic)
[66.585603] Starting subtest: basic
[76.541713] Subtest basic: SUCCESS (9.957s)
[76.730932] [026/165] (931s left) gem_exec_parallel (engines)
[76.950185] Starting subtest: engines
[76.951282] Starting dynamic subtest: basic
[79.711120] Dynamic subtest basic: SUCCESS (2.759s)
[79.724128] Starting dynamic subtest: contexts
[84.023944] Dynamic subtest contexts: SUCCESS (4.312s)
[84.037806] Starting dynamic subtest: fds
[94.195926] Dynamic subtest fds: SUCCESS (10.171s)
[94.208975] Starting dynamic subtest: userptr
[97.062056] Dynamic subtest userptr: SUCCESS (2.866s)
[97.063196] Subtest engines: SUCCESS (20.112s)
[97.258971] [027/165] (910s left) gem_exec_store (basic)
[97.382991] Starting subtest: basic
[97.429858] Subtest basic: SUCCESS (0.047s)
[97.613141] [028/165] (910s left) gem_flink_basic (bad-flink)
[97.716336] Starting subtest: bad-flink
[97.717419] Subtest bad-flink: SUCCESS (0.000s)
[97.795918] [029/165] (910s left) gem_flink_basic (bad-open)
[97.898064] Starting subtest: bad-open
[97.899178] Subtest bad-open: SUCCESS (0.000s)
[97.978182] [030/165] (910s left) gem_flink_basic (basic)
[98.080684] Starting subtest: basic
[98.081812] Subtest basic: SUCCESS (0.000s)
[98.161438] [031/165] (910s left) gem_flink_basic (double-flink)
[98.266396] Starting subtest: double-flink
[98.267521] Subtest double-flink: SUCCESS (0.000s)
[98.344938] [032/165] (910s left) gem_flink_basic (flink-lifetime)
[98.452462] Starting subtest: flink-lifetime
[98.453580] Subtest flink-lifetime: SUCCESS (0.002s)
[98.527398] [033/165] (909s left) gem_huc_copy (huc-copy)
[98.637289] Starting subtest: huc-copy
[98.640117] Subtest huc-copy: SKIP (0.000s)
[98.726914] [034/165] (909s left) gem_linear_blits (basic)
[98.978553] Starting subtest: basic
[98.996762] Subtest basic: SUCCESS (0.018s)
[99.143787] [035/165] (909s left) gem_mmap (basic)
[99.345957] Starting subtest: basic
[99.352304] Subtest basic: SUCCESS (0.001s)
[99.427777] [036/165] (909s left) gem_mmap_gtt (basic)
[99.535259] Starting subtest: basic
[99.536279] Subtest basic: SUCCESS (0.001s)
[99.597630] [037/165] (908s left) gem_render_linear_blits (basic)
[99.711078] Starting subtest: basic
[99.771918] Subtest basic: SUCCESS (0.058s)
[99.815329] [038/165] (908s left) gem_render_tiled_blits (basic)
[99.927793] Starting subtest: basic
[100.004911] Subtest basic: SUCCESS (0.076s)
[100.047480] [039/165] (908s left) gem_ringfill (basic-all)
[100.357929] Starting subtest: basic-all
[101.537958] Subtest basic-all: SUCCESS (1.180s)
[101.628959] [040/165] (906s left) gem_softpin (allocator-basic)
[101.739710] Starting subtest: allocator-basic
[101.921204] Subtest allocator-basic: SUCCESS (0.172s)
[102.011716] [041/165] (906s left) gem_softpin (allocator-basic-reserve)
[102.120171] Starting subtest: allocator-basic-reserve
[102.295418] Subtest allocator-basic-reserve: SUCCESS (0.171s)
[102.394578] [042/165] (906s left) gem_softpin (safe-alignment)
[102.508179] Starting subtest: safe-alignment
[102.528961] Subtest safe-alignment: SUCCESS (0.020s)
[102.610773] [043/165] (906s left) gem_sync (basic-all)
[102.738650] Starting subtest: basic-all
[104.780312] Subtest basic-all: SUCCESS (2.043s)
[104.979331] [044/165] (903s left) gem_sync (basic-each)
[105.102365] Starting subtest: basic-each
[107.502534] Subtest basic-each: SUCCESS (2.402s)
[107.693995] [045/165] (901s left) gem_tiled_blits (basic)
[107.919248] Starting subtest: basic
[107.954262] Subtest basic: SUCCESS (0.034s)
[108.092345] [046/165] (900s left) gem_tiled_fence_blits (basic)
[108.426678] Starting subtest: basic
[108.453690] Subtest basic: SUCCESS (0.029s)
[108.592874] [047/165] (900s left) gem_tiled_pread_basic
[109.114452] [048/165] (899s left) gem_wait (busy@all-engines)
[109.249224] Starting subtest: busy
[109.250355] Starting dynamic subtest: all-engines
[109.767866] Dynamic subtest all-engines: SUCCESS (0.517s)
[109.769205] Subtest busy: SUCCESS (0.519s)
[109.983307] [049/165] (898s left) gem_wait (wait@all-engines)
[110.112556] Starting subtest: wait
[110.117230] Starting dynamic subtest: all-engines
[111.148040] Dynamic subtest all-engines: SUCCESS (1.033s)
[111.149263] Subtest wait: SUCCESS (1.034s)
[111.360964] [050/165] (897s left) i915_getparams_basic (basic-eu-total)
[111.466437] Starting subtest: basic-eu-total
[111.468734] Subtest basic-eu-total: SUCCESS (0.000s)
[111.543813] [051/165] (897s left) i915_getparams_basic (basic-subslice-total)
[111.644908] Starting subtest: basic-subslice-total
[111.647923] Subtest basic-subslice-total: SUCCESS (0.000s)
[111.710881] [052/165] (897s left) i915_hangman (error-state-basic)
[111.832863] Starting subtest: error-state-basic
[111.850211] Subtest error-state-basic: SUCCESS (0.017s)
[111.944125] [053/165] (897s left) i915_pciid
[112.129420] [054/165] (896s left) kms_addfb_basic (addfb25-4-tiled)
[112.302912] Starting subtest: addfb25-4-tiled
[112.304345] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[112.375233] [055/165] (896s left) kms_addfb_basic (addfb25-bad-modifier)
[112.481635] Starting subtest: addfb25-bad-modifier
[112.482725] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[112.625968] [056/165] (896s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[112.733329] Starting subtest: addfb25-framebuffer-vs-set-tiling
[112.734458] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[112.876062] [057/165] (896s left) kms_addfb_basic (addfb25-modifier-no-flag)
[112.978410] Starting subtest: addfb25-modifier-no-flag
[112.979501] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[113.125842] [058/165] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[113.227387] Starting subtest: addfb25-x-tiled-legacy
[113.228516] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[113.360548] [059/165] (895s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[113.469177] Starting subtest: addfb25-x-tiled-mismatch-legacy
[113.470277] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[113.608939] [060/165] (895s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[113.774503] Starting subtest: addfb25-yf-tiled-legacy
[113.776093] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[113.859209] [061/165] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[114.022312] Starting subtest: addfb25-y-tiled-legacy
[114.023432] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[114.109090] [062/165] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[114.281793] Starting subtest: addfb25-y-tiled-small-legacy
[114.282886] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[114.358872] [063/165] (894s left) kms_addfb_basic (bad-pitch-0)
[114.461383] Starting subtest: bad-pitch-0
[114.462763] Subtest bad-pitch-0: SUCCESS (0.000s)
[114.609040] [064/165] (894s left) kms_addfb_basic (bad-pitch-1024)
[114.713363] Starting subtest: bad-pitch-1024
[114.715629] Subtest bad-pitch-1024: SUCCESS (0.000s)
[114.858869] [065/165] (894s left) kms_addfb_basic (bad-pitch-128)
[114.963803] Starting subtest: bad-pitch-128
[114.964917] Subtest bad-pitch-128: SUCCESS (0.000s)
[115.109793] [066/165] (894s left) kms_addfb_basic (bad-pitch-256)
[115.213126] Starting subtest: bad-pitch-256
[115.215597] Subtest bad-pitch-256: SUCCESS (0.000s)
[115.359803] [067/165] (894s left) kms_addfb_basic (bad-pitch-32)
[115.463276] Starting subtest: bad-pitch-32
[115.464426] Subtest bad-pitch-32: SUCCESS (0.000s)
[115.608614] [068/165] (893s left) kms_addfb_basic (bad-pitch-63)
[115.714852] Starting subtest: bad-pitch-63
[115.715934] Subtest bad-pitch-63: SUCCESS (0.000s)
[115.858658] [069/165] (893s left) kms_addfb_basic (bad-pitch-65536)
[115.962171] Starting subtest: bad-pitch-65536
[115.963256] Subtest bad-pitch-65536: SUCCESS (0.000s)
[116.109295] [070/165] (893s left) kms_addfb_basic (bad-pitch-999)
[116.213587] Starting subtest: bad-pitch-999
[116.215772] Subtest bad-pitch-999: SUCCESS (0.000s)
[116.358854] [071/165] (893s left) kms_addfb_basic (basic)
[116.460464] Starting subtest: basic
[116.461918] Subtest basic: SUCCESS (0.000s)
[116.592883] [072/165] (892s left) kms_addfb_basic (basic-x-tiled-legacy)
[116.702137] Starting subtest: basic-x-tiled-legacy
[116.703813] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[116.842520] [073/165] (892s left) kms_addfb_basic (basic-y-tiled-legacy)
[116.948940] Starting subtest: basic-y-tiled-legacy
[116.950055] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[117.091973] [074/165] (892s left) kms_addfb_basic (bo-too-small)
[117.259065] Starting subtest: bo-too-small
[117.260245] Subtest bo-too-small: SUCCESS (0.000s)
[117.341689] [075/165] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[117.506816] Starting subtest: bo-too-small-due-to-tiling
[117.509126] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[117.592960] [076/165] (892s left) kms_addfb_basic (clobberred-modifier)
[117.696705] Starting subtest: clobberred-modifier
[117.698835] Subtest clobberred-modifier: SUCCESS (0.000s)
[117.865754] [077/165] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[117.976083] Starting subtest: framebuffer-vs-set-tiling
[117.977179] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[118.108894] [078/165] (891s left) kms_addfb_basic (invalid-get-prop)
[118.213436] Starting subtest: invalid-get-prop
[118.214593] Subtest invalid-get-prop: SUCCESS (0.000s)
[118.359475] [079/165] (891s left) kms_addfb_basic (invalid-get-prop-any)
[118.465047] Starting subtest: invalid-get-prop-any
[118.466209] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[118.609538] [080/165] (891s left) kms_addfb_basic (invalid-set-prop)
[118.715481] Starting subtest: invalid-set-prop
[118.716900] Subtest invalid-set-prop: SUCCESS (0.000s)
[118.859088] [081/165] (890s left) kms_addfb_basic (invalid-set-prop-any)
[118.962374] Starting subtest: invalid-set-prop-any
[118.963449] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[119.092477] [082/165] (890s left) kms_addfb_basic (no-handle)
[119.197777] Starting subtest: no-handle
[119.198898] Subtest no-handle: SUCCESS (0.000s)
[119.341961] [083/165] (890s left) kms_addfb_basic (size-max)
[119.502411] Starting subtest: size-max
[119.503507] Subtest size-max: SUCCESS (0.000s)
[119.575683] [084/165] (890s left) kms_addfb_basic (small-bo)
[119.743051] Starting subtest: small-bo
[119.744625] Subtest small-bo: SUCCESS (0.000s)
[119.824884] [085/165] (890s left) kms_addfb_basic (tile-pitch-mismatch)
[119.932215] Starting subtest: tile-pitch-mismatch
[119.933315] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[120.083798] [086/165] (889s left) kms_addfb_basic (too-high)
[120.249769] Starting subtest: too-high
[120.255957] Subtest too-high: SUCCESS (0.003s)
[120.342560] [087/165] (889s left) kms_addfb_basic (too-wide)
[120.509385] Starting subtest: too-wide
[120.510603] Subtest too-wide: SUCCESS (0.000s)
[120.591633] [088/165] (889s left) kms_addfb_basic (unused-handle)
[120.695968] Starting subtest: unused-handle
[120.698137] Subtest unused-handle: SUCCESS (0.000s)
[120.842752] [089/165] (889s left) kms_addfb_basic (unused-modifier)
[120.945947] Starting subtest: unused-modifier
[120.948338] Subtest unused-modifier: SUCCESS (0.000s)
[121.093667] [090/165] (888s left) kms_addfb_basic (unused-offsets)
[121.199601] Starting subtest: unused-offsets
[121.200704] Subtest unused-offsets: SUCCESS (0.000s)
[121.342644] [091/165] (888s left) kms_addfb_basic (unused-pitches)
[121.450368] Starting subtest: unused-pitches
[121.451461] Subtest unused-pitches: SUCCESS (0.000s)
[121.576546] [092/165] (888s left) kms_busy (basic)
[121.741980] Starting subtest: basic
[121.747577] Starting dynamic subtest: flip
[122.628820] Dynamic subtest flip: SUCCESS (0.881s)
[122.647635] Starting dynamic subtest: modeset
[123.973100] Dynamic subtest modeset: SUCCESS (1.344s)
[123.977122] Subtest basic: SUCCESS (2.232s)
[124.161417] [093/165] (885s left) kms_prop_blob (basic)
[124.268340] Starting subtest: basic
[124.269431] Subtest basic: SUCCESS (0.000s)
[124.344940] [094/165] (885s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[124.504017] Starting subtest: basic-busy-flip-before-cursor-atomic
[124.506351] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[124.576205] [095/165] (885s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[124.751397] Starting subtest: basic-busy-flip-before-cursor-legacy
[124.753716] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[124.826091] [096/165] (885s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[124.996752] Starting subtest: basic-flip-after-cursor-atomic
[126.151584] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.154s)
[126.308904] [097/165] (883s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[126.468057] Starting subtest: basic-flip-after-cursor-legacy
[127.644555] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.174s)
[127.811980] [098/165] (882s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[127.980799] Starting subtest: basic-flip-after-cursor-varying-size
[129.162707] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.184s)
[129.340785] [099/165] (880s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[129.507111] Starting subtest: basic-flip-before-cursor-atomic
[130.677295] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.165s)
[130.856261] [100/165] (879s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[131.022742] Starting subtest: basic-flip-before-cursor-legacy
[132.184046] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.159s)
[132.351492] [101/165] (878s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[132.519589] Starting subtest: basic-flip-before-cursor-varying-size
[133.727697] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.207s)
[133.873600] [102/165] (876s left) kms_dsc (dsc-basic)
[134.041685] Subtest dsc-basic: SKIP (0.000s)
[134.092602] [103/165] (876s left) kms_flip (basic-flip-vs-dpms)
[134.264782] Starting subtest: basic-flip-vs-dpms
[134.269140] Starting dynamic subtest: A-HDMI-A2
[135.517299] Dynamic subtest A-HDMI-A2: SUCCESS (1.243s)
[135.538884] Starting dynamic subtest: B-HDMI-A2
[136.473586] Dynamic subtest B-HDMI-A2: SUCCESS (0.950s)
[136.497026] Starting dynamic subtest: C-HDMI-A2
[137.432569] Dynamic subtest C-HDMI-A2: SUCCESS (0.967s)
[137.433734] Subtest basic-flip-vs-dpms: SUCCESS (3.169s)
[137.624199] [104/165] (872s left) kms_flip (basic-flip-vs-modeset)
[137.803055] Starting subtest: basic-flip-vs-modeset
[137.807023] Starting dynamic subtest: A-HDMI-A2
[139.113898] Dynamic subtest A-HDMI-A2: SUCCESS (1.299s)
[139.130268] Starting dynamic subtest: B-HDMI-A2
[140.129432] Dynamic subtest B-HDMI-A2: SUCCESS (1.011s)
[140.151705] Starting dynamic subtest: C-HDMI-A2
[141.151144] Dynamic subtest C-HDMI-A2: SUCCESS (1.020s)
[141.152264] Subtest basic-flip-vs-modeset: SUCCESS (3.348s)
[141.326803] [105/165] (869s left) kms_flip (basic-flip-vs-wf_vblank)
[141.502921] Starting subtest: basic-flip-vs-wf_vblank
[141.513021] Starting dynamic subtest: A-HDMI-A2
[142.948867] Dynamic subtest A-HDMI-A2: SUCCESS (1.432s)
[142.967214] Starting dynamic subtest: B-HDMI-A2
[144.270331] Dynamic subtest B-HDMI-A2: SUCCESS (1.324s)
[144.292218] Starting dynamic subtest: C-HDMI-A2
[145.634644] Dynamic subtest C-HDMI-A2: SUCCESS (1.360s)
[145.635783] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.130s)
[146.031452] [106/165] (864s left) kms_flip (basic-plain-flip)
[146.201616] Starting subtest: basic-plain-flip
[146.209668] Starting dynamic subtest: A-HDMI-A2
[147.361414] Dynamic subtest A-HDMI-A2: SUCCESS (1.150s)
[147.379659] Starting dynamic subtest: B-HDMI-A2
[148.388771] Dynamic subtest B-HDMI-A2: SUCCESS (1.027s)
[148.405694] Starting dynamic subtest: C-HDMI-A2
[149.454632] Dynamic subtest C-HDMI-A2: SUCCESS (1.063s)
[149.457817] Subtest basic-plain-flip: SUCCESS (3.254s)
[149.837248] [107/165] (860s left) kms_force_connector_basic (force-connector-state)
[150.031117] Starting subtest: force-connector-state
[150.430707] Subtest force-connector-state: SUCCESS (0.401s)
[150.906862] [108/165] (859s left) kms_force_connector_basic (force-edid)
[151.098968] Starting subtest: force-edid
[151.165231] Subtest force-edid: SUCCESS (0.066s)
[151.457406] [109/165] (859s left) kms_force_connector_basic (force-load-detect)
[151.646445] Starting subtest: force-load-detect
[151.649891] Subtest force-load-detect: SKIP (0.000s)
[151.890032] [110/165] (858s left) kms_force_connector_basic (prune-stale-modes)
[152.094650] Starting subtest: prune-stale-modes
[152.130593] Subtest prune-stale-modes: SUCCESS (0.033s)
[152.407102] [111/165] (858s left) kms_frontbuffer_tracking (basic)
[152.602616] Starting subtest: basic
[155.416368] Subtest basic: SUCCESS (2.809s)
[155.508554] [112/165] (855s left) kms_hdmi_inject (inject-audio)
[155.824804] Starting subtest: inject-audio
[156.016520] Subtest inject-audio: SUCCESS (0.192s)
[156.355170] [113/165] (854s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[156.521791] Starting subtest: compare-crc-sanitycheck-xr24
[156.524732] Starting dynamic subtest: pipe-A-HDMI-A-2
[157.064843] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.537s)
[157.084068] Starting dynamic subtest: pipe-B-HDMI-A-2
[157.584208] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.511s)
[157.607190] Starting dynamic subtest: pipe-C-HDMI-A-2
[158.141925] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.551s)
[158.143584] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.617s)
[158.307671] [114/165] (852s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[158.477341] Starting subtest: compare-crc-sanitycheck-nv12
[158.478428] Starting dynamic subtest: pipe-A-HDMI-A-2
[159.126056] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.647s)
[159.144822] Starting dynamic subtest: pipe-B-HDMI-A-2
[159.825040] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.689s)
[159.851938] Starting dynamic subtest: pipe-C-HDMI-A-2
[160.466145] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.640s)
[160.468556] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.989s)
[160.628935] [115/165] (850s left) kms_pipe_crc_basic (hang-read-crc)
[160.811178] Starting subtest: hang-read-crc
[160.812255] Starting dynamic subtest: pipe-A-HDMI-A-2
[162.148824] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.335s)
[162.168048] Starting dynamic subtest: pipe-B-HDMI-A-2
[163.430145] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.274s)
[163.445947] Starting dynamic subtest: pipe-C-HDMI-A-2
[164.673059] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.239s)
[164.674155] Subtest hang-read-crc: SUCCESS (3.865s)
[164.832593] [116/165] (845s left) kms_pipe_crc_basic (nonblocking-crc)
[164.997318] Starting subtest: nonblocking-crc
[164.998453] Starting dynamic subtest: pipe-A-HDMI-A-2
[165.719375] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.717s)
[165.735247] Starting dynamic subtest: pipe-B-HDMI-A-2
[166.446600] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.721s)
[166.465585] Starting dynamic subtest: pipe-C-HDMI-A-2
[167.141188] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.687s)
[167.142506] Subtest nonblocking-crc: SUCCESS (2.144s)
[167.294934] [117/165] (843s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[167.459204] Starting subtest: nonblocking-crc-frame-sequence
[167.460333] Starting dynamic subtest: pipe-A-HDMI-A-2
[168.196946] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.738s)
[168.217129] Starting dynamic subtest: pipe-B-HDMI-A-2
[168.923327] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.717s)
[168.943699] Starting dynamic subtest: pipe-C-HDMI-A-2
[169.626986] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.696s)
[169.629606] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.174s)
[169.832118] [118/165] (841s left) kms_pipe_crc_basic (read-crc)
[170.005293] Starting subtest: read-crc
[170.006420] Starting dynamic subtest: pipe-A-HDMI-A-2
[170.650514] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.644s)
[170.673294] Starting dynamic subtest: pipe-B-HDMI-A-2
[171.281634] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.623s)
[171.297956] Starting dynamic subtest: pipe-C-HDMI-A-2
[171.914952] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.628s)
[171.916589] Subtest read-crc: SUCCESS (1.914s)
[172.075376] [119/165] (838s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[172.255222] Starting subtest: read-crc-frame-sequence
[172.257840] Starting dynamic subtest: pipe-A-HDMI-A-2
[172.932015] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.674s)
[172.949789] Starting dynamic subtest: pipe-B-HDMI-A-2
[173.572134] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.633s)
[173.593082] Starting dynamic subtest: pipe-C-HDMI-A-2
[174.219927] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.641s)
[174.221044] Subtest read-crc-frame-sequence: SUCCESS (1.968s)
[174.377833] [120/165] (836s left) kms_pm_backlight (basic-brightness)
[174.538781] Subtest basic-brightness: SKIP (0.000s)
[174.582117] [121/165] (836s left) kms_pm_rpm (basic-pci-d3-state)
[176.279659] Starting subtest: basic-pci-d3-state
[176.614151] Subtest basic-pci-d3-state: SUCCESS (0.332s)
[176.803741] [122/165] (834s left) kms_pm_rpm (basic-rte)
[176.908137] Starting subtest: basic-rte
[178.920019] Subtest basic-rte: SUCCESS (2.008s)
[179.682650] [123/165] (831s left) kms_psr (psr-primary-page-flip)
[179.857746] Subtest psr-primary-page-flip: SKIP (0.000s)
[179.901041] [124/165] (831s left) kms_psr (psr-cursor-plane-move)
[180.061239] Subtest psr-cursor-plane-move: SKIP (0.000s)
[180.101592] [125/165] (830s left) kms_psr (psr-sprite-plane-onoff)
[180.261738] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[180.301033] [126/165] (830s left) kms_psr (psr-primary-mmap-gtt)
[180.475047] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[180.517957] [127/165] (830s left) kms_setmode (basic-clone-single-crtc)
[180.622682] Starting subtest: basic-clone-single-crtc
[180.627350] Subtest basic-clone-single-crtc: SKIP (0.000s)
[180.700217] [128/165] (830s left) i915_pm_rps (basic-api)
[180.823125] Starting subtest: basic-api
[180.830187] Subtest basic-api: SUCCESS (0.009s)
[180.916597] [129/165] (830s left) prime_self_import (basic-llseek-bad)
[181.022667] Starting subtest: basic-llseek-bad
[181.025344] Subtest basic-llseek-bad: SUCCESS (0.003s)
[181.099134] [130/165] (830s left) prime_self_import (basic-llseek-size)
[181.201449] Starting subtest: basic-llseek-size
[181.206562] Subtest basic-llseek-size: SUCCESS (0.005s)
[181.282116] [131/165] (829s left) prime_self_import (basic-with_fd_dup)
[181.384394] Starting subtest: basic-with_fd_dup
[181.386887] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[181.465395] [132/165] (829s left) prime_self_import (basic-with_one_bo)
[181.565693] Starting subtest: basic-with_one_bo
[181.579272] Subtest basic-with_one_bo: SUCCESS (0.010s)
[181.653129] [133/165] (829s left) prime_self_import (basic-with_one_bo_two_files)
[181.755329] Starting subtest: basic-with_one_bo_two_files
[181.759583] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[181.849152] [134/165] (829s left) prime_self_import (basic-with_two_bos)
[181.952176] Starting subtest: basic-with_two_bos
[181.954443] Subtest basic-with_two_bos: SUCCESS (0.004s)
[182.033404] [135/165] (829s left) prime_vgem (basic-fence-flip)
[182.163192] Starting subtest: basic-fence-flip
[182.669103] Subtest basic-fence-flip: SUCCESS (0.504s)
[182.767609] [136/165] (828s left) prime_vgem (basic-fence-mmap)
[182.896190] Starting subtest: basic-fence-mmap
[182.952396] Subtest basic-fence-mmap: SUCCESS (0.057s)
[183.034809] [137/165] (828s left) prime_vgem (basic-fence-read)
[183.163724] Starting subtest: basic-fence-read
[183.260165] Subtest basic-fence-read: SUCCESS (0.095s)
[183.350492] [138/165] (828s left) prime_vgem (basic-gtt)
[183.480581] Starting subtest: basic-gtt
[183.512817] Subtest basic-gtt: SUCCESS (0.030s)
[183.599113] [139/165] (827s left) prime_vgem (basic-read)
[183.730016] Starting subtest: basic-read
[183.779342] Subtest basic-read: SUCCESS (0.048s)
[183.866091] [140/165] (827s left) prime_vgem (basic-write)
[183.998251] Starting subtest: basic-write
[184.050144] Subtest basic-write: SUCCESS (0.055s)
[184.132805] [141/165] (827s left) vgem_basic (setversion)
[184.252889] Starting subtest: setversion
[184.255570] Subtest setversion: SUCCESS (0.000s)
[184.315823] [142/165] (827s left) vgem_basic (create)
[184.439566] Starting subtest: create
[184.441416] Subtest create: SUCCESS (0.001s)
[184.500842] [143/165] (827s left) vgem_basic (debugfs)
[184.619423] Starting subtest: debugfs
[184.620723] Subtest debugfs: SUCCESS (0.001s)
[184.683642] [144/165] (826s left) vgem_basic (dmabuf-export)
[184.806196] Starting subtest: dmabuf-export
[184.808837] Subtest dmabuf-export: SUCCESS (0.003s)
[184.901576] [145/165] (826s left) vgem_basic (dmabuf-fence)
[185.021189] Starting subtest: dmabuf-fence
[185.022969] Subtest dmabuf-fence: SUCCESS (0.001s)
[185.082126] [146/165] (826s left) vgem_basic (dmabuf-fence-before)
[185.207066] Starting subtest: dmabuf-fence-before
[185.208972] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[185.265393] [147/165] (826s left) vgem_basic (dmabuf-mmap)
[185.386454] Starting subtest: dmabuf-mmap
[185.414274] Subtest dmabuf-mmap: SUCCESS (0.030s)
[185.481996] [148/165] (826s left) vgem_basic (mmap)
[185.603690] Starting subtest: mmap
[185.621548] Subtest mmap: SUCCESS (0.019s)
[185.681993] [149/165] (826s left) vgem_basic (second-client)
[185.804219] Starting subtest: second-client
[185.837029] Subtest second-client: SUCCESS (0.031s)
[185.899478] [150/165] (825s left) vgem_basic (sysfs)
[186.020815] Starting subtest: sysfs
[186.022932] Subtest sysfs: SUCCESS (0.002s)
[186.083089] [151/165] (825s left) core_hotunplug (unbind-rebind)
[186.253317] Starting subtest: unbind-rebind
[189.634845] Subtest unbind-rebind: SUCCESS (3.381s)
[189.672828] [152/165] (822s left) vgem_basic (unload)
[189.783709] Starting subtest: unload
[218.715089] Subtest unload: SUCCESS (28.929s)
[218.832669] [153/165] (793s left) i915_module_load (reload)
[218.940213] Starting subtest: reload
[221.367491] Subtest reload: SUCCESS (2.429s)
[221.446820] [154/165] (790s left) gem_lmem_swapping (basic)
[221.710834] Subtest basic: SKIP (0.000s)
[221.760120] [155/165] (790s left) gem_lmem_swapping (parallel-random-engines)
[221.920055] Subtest parallel-random-engines: SKIP (0.000s)
[221.962363] [156/165] (790s left) gem_lmem_swapping (random-engines)
[222.076698] Subtest random-engines: SKIP (0.000s)
[222.115555] [157/165] (790s left) gem_lmem_swapping (verify-random)
[222.225644] Subtest verify-random: SKIP (0.000s)
[222.264582] [158/165] (789s left) i915_pm_rpm (module-reload)
[224.240715] Starting subtest: module-reload
[231.667467] Subtest module-reload: SUCCESS (7.427s)
[231.695275] [159/165] (780s left) i915_selftest (live)
[231.818913] Starting subtest: live
[231.820136] Starting dynamic subtest: sanitycheck
[232.648204] Dynamic subtest sanitycheck: SUCCESS (0.829s)
[232.659102] Starting dynamic subtest: uncore
[233.413672] Dynamic subtest uncore: SUCCESS (0.764s)
[233.424305] Starting dynamic subtest: workarounds
[234.345291] Dynamic subtest workarounds: SUCCESS (0.927s)
[234.356234] Starting dynamic subtest: gt_engines
[235.671617] Dynamic subtest gt_engines: SUCCESS (1.324s)
[235.685174] Starting dynamic subtest: gt_timelines
[248.291184] Dynamic subtest gt_timelines: SUCCESS (12.615s)
[248.301981] Starting dynamic subtest: gt_contexts
[249.221215] Dynamic subtest gt_contexts: SUCCESS (0.926s)
[249.232427] Starting dynamic subtest: gt_lrc
[252.585656] Dynamic subtest gt_lrc: SUCCESS (3.364s)
[252.596174] Starting dynamic subtest: gt_mocs
[253.482909] Dynamic subtest gt_mocs: SUCCESS (0.894s)
[253.494092] Starting dynamic subtest: gt_pm
[261.087770] Dynamic subtest gt_pm: SUCCESS (7.602s)
[261.098353] Starting dynamic subtest: gt_heartbeat
[261.986415] Dynamic subtest gt_heartbeat: SUCCESS (0.896s)
[261.998072] Starting dynamic subtest: gt_tlb
[263.575173] Dynamic subtest gt_tlb: SUCCESS (1.583s)
[263.586304] Starting dynamic subtest: requests
[270.866113] Dynamic subtest requests: SUCCESS (7.290s)
[270.876841] Starting dynamic subtest: migrate
[274.602902] Dynamic subtest migrate: SUCCESS (3.734s)
[274.613509] Starting dynamic subtest: active
[275.461291] Dynamic subtest active: SUCCESS (0.856s)
[275.472422] Starting dynamic subtest: objects
[278.367737] Dynamic subtest objects: SUCCESS (2.905s)
[278.380777] Starting dynamic subtest: mman
[285.183085] Dynamic subtest mman: SUCCESS (6.811s)
[285.194766] Starting dynamic subtest: dmabuf
[286.002144] Dynamic subtest dmabuf: SUCCESS (0.816s)
[286.013216] Starting dynamic subtest: vma
[286.838352] Dynamic subtest vma: SUCCESS (0.834s)
[286.849446] Starting dynamic subtest: coherency
[289.596799] Dynamic subtest coherency: SUCCESS (2.755s)
[289.607394] Starting dynamic subtest: gtt
[297.833981] Dynamic subtest gtt: SUCCESS (8.234s)
[297.844801] Starting dynamic subtest: gem
[298.764370] Dynamic subtest gem: SUCCESS (0.928s)
[298.775222] Starting dynamic subtest: evict
[301.970388] Dynamic subtest evict: SUCCESS (3.204s)
[301.981034] Starting dynamic subtest: hugepages
[309.260435] Dynamic subtest hugepages: SUCCESS (7.287s)
[309.284472] Starting dynamic subtest: gem_contexts
[326.222343] Dynamic subtest gem_contexts: SUCCESS (16.956s)
[326.234753] Starting dynamic subtest: client
[327.032637] Dynamic subtest client: SUCCESS (0.809s)
[327.043945] Starting dynamic subtest: gem_migrate
[327.979661] Dynamic subtest gem_migrate: SUCCESS (0.944s)
[328.003138] Starting dynamic subtest: reset
[333.253531] Dynamic subtest reset: SUCCESS (5.270s)
[333.264535] Starting dynamic subtest: memory_region
[334.105879] Dynamic subtest memory_region: SUCCESS (0.850s)
[334.117085] Starting dynamic subtest: hangcheck
[357.866130] Dynamic subtest hangcheck: SUCCESS (23.756s)
[357.877563] Starting dynamic subtest: execlists
[367.794538] Dynamic subtest execlists: SUCCESS (9.928s)
[367.805459] Starting dynamic subtest: ring_submission
[368.752963] Dynamic subtest ring_submission: SUCCESS (0.956s)
[368.766823] Starting dynamic subtest: perf
[369.682127] Dynamic subtest perf: SUCCESS (0.925s)
[369.693565] Starting dynamic subtest: slpc
[370.519373] Dynamic subtest slpc: SUCCESS (0.834s)
[370.531176] Starting dynamic subtest: guc
[371.335863] Dynamic subtest guc: SUCCESS (0.812s)
[371.347572] Starting dynamic subtest: guc_multi_lrc
[372.165204] Dynamic subtest guc_multi_lrc: SUCCESS (0.825s)
[372.176635] Starting dynamic subtest: guc_hang
[372.982861] Dynamic subtest guc_hang: SUCCESS (0.817s)
[372.994747] Starting dynamic subtest: late_gt_pm
[373.916228] Dynamic subtest late_gt_pm: SUCCESS (0.930s)
[373.917296] Subtest live: SUCCESS (142.100s)
[373.950698] [160/165] (638s left) dmabuf (all-tests)
[374.063194] Starting subtest: all-tests
[374.067305] Starting dynamic subtest: sanitycheck
[374.127070] Dynamic subtest sanitycheck: SUCCESS (0.061s)
[374.141035] Starting dynamic subtest: dma_fence
[374.319863] Dynamic subtest dma_fence: SUCCESS (0.192s)
[374.337062] Starting dynamic subtest: dma_fence_chain
[392.258121] Dynamic subtest dma_fence_chain: SUCCESS (17.932s)
[392.275651] Starting dynamic subtest: dma_fence_unwrap
[392.312860] Dynamic subtest dma_fence_unwrap: SUCCESS (0.054s)
[392.331355] Starting dynamic subtest: dma_resv
[392.384970] Dynamic subtest dma_resv: SUCCESS (0.068s)
[392.387179] Subtest all-tests: SUCCESS (18.325s)
[392.414340] [161/165] (619s left) i915_suspend (basic-s2idle-without-i915)
[392.517849] Starting subtest: basic-s2idle-without-i915
[411.178388] Subtest basic-s2idle-without-i915: SUCCESS (3.477s)
[415.416087] [162/165] (616s left) i915_suspend (basic-s3-without-i915)
[415.535264] Starting subtest: basic-s3-without-i915
[436.068322] Subtest basic-s3-without-i915: SUCCESS (2.365s)
[438.122878] [163/165] (611s left) gem_exec_suspend (basic-s0)
[438.256643] Starting subtest: basic-S0
[438.258299] Starting dynamic subtest: smem
[457.760676] Dynamic subtest smem: SUCCESS (3.926s)
[457.761757] Subtest basic-S0: SUCCESS (3.929s)
[462.940956] [164/165] (607s left) gem_exec_suspend (basic-s3)
[463.065458] Starting subtest: basic-S3
[463.067395] Starting dynamic subtest: smem
[483.384208] Dynamic subtest smem: SUCCESS (3.654s)
[483.386010] Subtest basic-S3: SUCCESS (3.657s)
[486.417729] [165/165] (603s left) kms_pipe_crc_basic (suspend-read-crc)
[486.588551] Starting subtest: suspend-read-crc
[486.598187] Starting dynamic subtest: pipe-A-HDMI-A-2
[506.306034] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.934s)
[506.336021] Starting dynamic subtest: pipe-B-HDMI-A-2
[525.467687] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.396s)
[525.518391] Starting dynamic subtest: pipe-C-HDMI-A-2
[544.887056] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.762s)
[544.907739] Subtest suspend-read-crc: SUCCESS (7.108s)
[547.086225] Closing watchdogs
Done.