[95.414702] Initializing watchdogs
[95.415683]   /dev/watchdog0
[95.486827] [001/165] (960s left) i915_module_load (load)
[96.209741] Starting subtest: load
[101.151410] Subtest load: SUCCESS (4.935s)
[101.305738] [002/165] (954s left) core_auth (basic-auth)
[102.247894] Starting subtest: basic-auth
[102.253913] Subtest basic-auth: SUCCESS (0.004s)
[102.394137] [003/165] (953s left) debugfs_test (read_all_entries)
[102.833825] Starting subtest: read_all_entries
[103.004923] Subtest read_all_entries: SUCCESS (0.168s)
[103.171555] [004/165] (953s left) debugfs_test (basic-hwmon)
[103.607702] Starting subtest: basic-hwmon
[103.616185] Subtest basic-hwmon: SKIP (0.000s)
[103.776807] [005/165] (952s left) fbdev (eof)
[104.198342] Starting subtest: eof
[104.202416] Subtest eof: SUCCESS (0.004s)
[104.323224] [006/165] (952s left) fbdev (info)
[104.726827] Starting subtest: info
[104.730873] Subtest info: SUCCESS (0.000s)
[104.842263] [007/165] (951s left) fbdev (nullptr)
[105.247381] Starting subtest: nullptr
[105.251508] Subtest nullptr: SUCCESS (0.000s)
[105.356758] [008/165] (951s left) fbdev (read)
[105.781263] Starting subtest: read
[106.067299] Subtest read: SUCCESS (0.285s)
[106.174817] [009/165] (950s left) fbdev (write)
[106.650967] Starting subtest: write
[106.814748] Subtest write: SUCCESS (0.165s)
[106.926293] [010/165] (949s left) gem_basic (bad-close)
[107.332604] Starting subtest: bad-close
[107.340485] Subtest bad-close: SUCCESS (0.000s)
[107.460208] [011/165] (949s left) gem_basic (create-close)
[107.867708] Starting subtest: create-close
[107.875413] Subtest create-close: SUCCESS (0.001s)
[107.991926] [012/165] (948s left) gem_basic (create-fd-close)
[108.403408] Starting subtest: create-fd-close
[108.409963] Subtest create-fd-close: SUCCESS (0.002s)
[108.544081] [013/165] (948s left) gem_busy (busy@all-engines)
[109.035235] Starting subtest: busy
[109.039812] Starting dynamic subtest: all-engines
[109.147704] Dynamic subtest all-engines: SUCCESS (0.117s)
[109.150756] Subtest busy: SUCCESS (0.120s)
[109.647359] [014/165] (947s left) gem_close_race (basic-process)
[110.145393] Starting subtest: basic-process
[110.322571] Subtest basic-process: SUCCESS (0.179s)
[110.597110] [015/165] (946s left) gem_close_race (basic-threads)
[111.085643] Starting subtest: basic-threads
[112.504124] Subtest basic-threads: SUCCESS (1.424s)
[112.767433] [016/165] (944s left) gem_ctx_create (basic)
[113.189646] Subtest basic: SKIP (0.000s)
[113.293334] [017/165] (944s left) gem_ctx_create (basic-files)
[113.715169] Subtest basic-files: SKIP (0.000s)
[113.805324] [018/165] (943s left) gem_ctx_exec (basic)
[114.219760] Subtest basic: SKIP (0.000s)
[114.339250] [019/165] (943s left) gem_exec_basic (basic)
[114.788409] Starting subtest: basic
[114.792298] Starting dynamic subtest: rcs0-smem
[114.795219] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[114.798306] Subtest basic: SUCCESS (0.005s)
[115.071086] [020/165] (942s left) gem_exec_create (basic)
[115.531818] Starting subtest: basic
[115.536278] Starting dynamic subtest: smem
[117.665457] Dynamic subtest smem: SUCCESS (2.132s)
[117.669326] Subtest basic: SUCCESS (2.134s)
[117.940298] [021/165] (939s left) gem_exec_fence (basic-busy)
[118.640167] Starting subtest: basic-busy
[118.643682] Starting dynamic subtest: rcs0
[118.674822] Dynamic subtest rcs0: SUCCESS (0.036s)
[118.678983] Subtest basic-busy: SUCCESS (0.039s)
[119.560483] [022/165] (938s left) gem_exec_fence (basic-wait)
[120.227933] Starting subtest: basic-wait
[120.232314] Starting dynamic subtest: rcs0
[120.256716] Dynamic subtest rcs0: SUCCESS (0.027s)
[120.259673] Subtest basic-wait: SUCCESS (0.030s)
[120.944492] [023/165] (936s left) gem_exec_fence (basic-await)
[121.854243] Starting subtest: basic-await
[121.858714] Starting dynamic subtest: rcs0
[122.012817] Dynamic subtest rcs0: SUCCESS (0.157s)
[122.019751] Subtest basic-await: SUCCESS (0.160s)
[122.946391] [024/165] (934s left) gem_exec_fence (nb-await)
[123.897694] Starting subtest: nb-await
[123.902253] Starting dynamic subtest: rcs0
[123.966146] Dynamic subtest rcs0: SUCCESS (0.066s)
[123.970283] Subtest nb-await: SUCCESS (0.069s)
[124.668387] [025/165] (933s left) gem_exec_gttfill (basic)
[125.174664] Starting subtest: basic
[139.934908] Subtest basic: SUCCESS (14.752s)
[140.297625] [026/165] (917s left) gem_exec_parallel (engines)
[141.170838] Starting subtest: engines
[141.175656] Starting dynamic subtest: basic
[144.566493] Dynamic subtest basic: SUCCESS (3.394s)
[144.604804] Starting dynamic subtest: contexts
[144.610743] Dynamic subtest contexts: SKIP (0.003s)
[144.645591] Starting dynamic subtest: fds
[144.650940] Dynamic subtest fds: SKIP (0.003s)
[144.684945] Starting dynamic subtest: userptr
[148.028604] Dynamic subtest userptr: SUCCESS (3.450s)
[148.031925] Subtest engines: SUCCESS (6.855s)
[148.316913] [027/165] (909s left) gem_exec_store (basic)
[148.800385] Starting subtest: basic
[148.853340] Subtest basic: SUCCESS (0.054s)
[149.131530] [028/165] (909s left) gem_flink_basic (bad-flink)
[149.548330] Starting subtest: bad-flink
[149.552896] Subtest bad-flink: SUCCESS (0.000s)
[149.677255] [029/165] (908s left) gem_flink_basic (bad-open)
[150.092609] Starting subtest: bad-open
[150.096577] Subtest bad-open: SUCCESS (0.000s)
[150.231917] [030/165] (908s left) gem_flink_basic (basic)
[150.631172] Starting subtest: basic
[150.635316] Subtest basic: SUCCESS (0.001s)
[150.782412] [031/165] (907s left) gem_flink_basic (double-flink)
[151.191795] Starting subtest: double-flink
[151.197191] Subtest double-flink: SUCCESS (0.001s)
[151.333080] [032/165] (907s left) gem_flink_basic (flink-lifetime)
[151.733877] Starting subtest: flink-lifetime
[151.738564] Subtest flink-lifetime: SUCCESS (0.007s)
[151.880196] [033/165] (906s left) gem_huc_copy (huc-copy)
[152.294722] Subtest huc-copy: SKIP (0.000s)
[152.406584] [034/165] (906s left) gem_linear_blits (basic)
[153.220306] Starting subtest: basic
[153.274517] Subtest basic: SUCCESS (0.054s)
[153.511267] [035/165] (905s left) gem_mmap (basic)
[154.216081] Starting subtest: basic
[154.233830] Subtest basic: SUCCESS (0.003s)
[154.353640] [036/165] (904s left) gem_mmap_gtt (basic)
[154.764852] Starting subtest: basic
[154.769513] Subtest basic: SUCCESS (0.004s)
[154.889779] [037/165] (904s left) gem_render_linear_blits (basic)
[155.310519] Starting subtest: basic
[155.438611] Subtest basic: SUCCESS (0.128s)
[155.573812] [038/165] (903s left) gem_render_tiled_blits (basic)
[156.002441] Starting subtest: basic
[156.138564] Subtest basic: SUCCESS (0.137s)
[156.274805] [039/165] (903s left) gem_ringfill (basic-all)
[156.733491] Starting subtest: basic-all
[157.928964] Subtest basic-all: SUCCESS (1.194s)
[158.071285] [040/165] (901s left) gem_softpin (allocator-basic)
[158.497150] Subtest allocator-basic: SKIP (0.000s)
[158.621497] [041/165] (900s left) gem_softpin (allocator-basic-reserve)
[159.047310] Subtest allocator-basic-reserve: SKIP (0.000s)
[159.171899] [042/165] (900s left) gem_softpin (safe-alignment)
[159.595698] Starting subtest: safe-alignment
[159.621649] Subtest safe-alignment: SUCCESS (0.034s)
[159.756667] [043/165] (899s left) gem_sync (basic-all)
[160.215716] Starting subtest: basic-all
[162.563212] Subtest basic-all: SUCCESS (2.345s)
[162.843151] [044/165] (896s left) gem_sync (basic-each)
[163.310228] Starting subtest: basic-each
[165.654324] Subtest basic-each: SUCCESS (2.342s)
[165.932321] [045/165] (893s left) gem_tiled_blits (basic)
[166.599434] Starting subtest: basic
[166.694547] Subtest basic: SUCCESS (0.096s)
[166.926889] [046/165] (892s left) gem_tiled_fence_blits (basic)
[167.951219] Starting subtest: basic
[168.024563] Subtest basic: SUCCESS (0.074s)
[168.247336] [047/165] (891s left) gem_tiled_pread_basic
[170.755757] [048/165] (889s left) gem_wait (busy@all-engines)
[171.274896] Starting subtest: busy
[171.279170] Starting dynamic subtest: all-engines
[171.812257] Dynamic subtest all-engines: SUCCESS (0.537s)
[171.815703] Subtest busy: SUCCESS (0.540s)
[172.222992] [049/165] (887s left) gem_wait (wait@all-engines)
[172.733619] Starting subtest: wait
[172.741133] Starting dynamic subtest: all-engines
[173.776175] Dynamic subtest all-engines: SUCCESS (1.040s)
[173.780472] Subtest wait: SUCCESS (1.043s)
[174.209425] [050/165] (886s left) i915_getparams_basic (basic-eu-total)
[174.649622] Starting subtest: basic-eu-total
[174.657317] Subtest basic-eu-total: SUCCESS (0.000s)
[174.774474] [051/165] (885s left) i915_getparams_basic (basic-subslice-total)
[175.194301] Starting subtest: basic-subslice-total
[175.201895] Subtest basic-subslice-total: SUCCESS (0.000s)
[175.325485] [052/165] (885s left) i915_hangman (error-state-basic)
[175.758912] Starting subtest: error-state-basic
[176.128831] Subtest error-state-basic: SUCCESS (0.370s)
[176.251895] [053/165] (884s left) i915_pciid
[176.796191] [054/165] (883s left) kms_addfb_basic (addfb25-4-tiled)
[177.291963] Starting subtest: addfb25-4-tiled
[177.296488] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[177.468701] [055/165] (883s left) kms_addfb_basic (addfb25-bad-modifier)
[177.934413] Starting subtest: addfb25-bad-modifier
[177.938712] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[178.136670] [056/165] (882s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[178.556660] Starting subtest: addfb25-framebuffer-vs-set-tiling
[178.560787] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[178.752328] [057/165] (882s left) kms_addfb_basic (addfb25-modifier-no-flag)
[179.167678] Starting subtest: addfb25-modifier-no-flag
[179.171567] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[179.371216] [058/165] (881s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[179.795240] Starting subtest: addfb25-x-tiled-legacy
[179.798892] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[179.998157] [059/165] (881s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[180.423224] Starting subtest: addfb25-x-tiled-mismatch-legacy
[180.426833] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[180.603583] [060/165] (880s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[181.062831] Starting subtest: addfb25-yf-tiled-legacy
[181.067829] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[181.219385] [061/165] (880s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[181.687557] Starting subtest: addfb25-y-tiled-legacy
[181.691726] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[181.833942] [062/165] (879s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[182.300756] Starting subtest: addfb25-y-tiled-small-legacy
[182.307641] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[182.452827] [063/165] (878s left) kms_addfb_basic (bad-pitch-0)
[182.859701] Starting subtest: bad-pitch-0
[182.864410] Subtest bad-pitch-0: SUCCESS (0.000s)
[183.065833] [064/165] (878s left) kms_addfb_basic (bad-pitch-1024)
[183.473835] Starting subtest: bad-pitch-1024
[183.478325] Subtest bad-pitch-1024: SUCCESS (0.000s)
[183.689561] [065/165] (877s left) kms_addfb_basic (bad-pitch-128)
[184.108917] Starting subtest: bad-pitch-128
[184.113383] Subtest bad-pitch-128: SUCCESS (0.000s)
[184.286972] [066/165] (877s left) kms_addfb_basic (bad-pitch-256)
[184.702175] Starting subtest: bad-pitch-256
[184.706661] Subtest bad-pitch-256: SUCCESS (0.000s)
[184.904716] [067/165] (876s left) kms_addfb_basic (bad-pitch-32)
[185.333685] Starting subtest: bad-pitch-32
[185.337638] Subtest bad-pitch-32: SUCCESS (0.000s)
[185.544520] [068/165] (876s left) kms_addfb_basic (bad-pitch-63)
[185.959123] Starting subtest: bad-pitch-63
[185.963571] Subtest bad-pitch-63: SUCCESS (0.000s)
[186.147936] [069/165] (875s left) kms_addfb_basic (bad-pitch-65536)
[186.562238] Starting subtest: bad-pitch-65536
[186.566236] Subtest bad-pitch-65536: SUCCESS (0.002s)
[186.773254] [070/165] (875s left) kms_addfb_basic (bad-pitch-999)
[187.185623] Starting subtest: bad-pitch-999
[187.188906] Subtest bad-pitch-999: SUCCESS (0.000s)
[187.374742] [071/165] (874s left) kms_addfb_basic (basic)
[187.779327] Starting subtest: basic
[187.784508] Subtest basic: SUCCESS (0.000s)
[187.977523] [072/165] (874s left) kms_addfb_basic (basic-x-tiled-legacy)
[188.388260] Starting subtest: basic-x-tiled-legacy
[188.392392] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[188.578707] [073/165] (873s left) kms_addfb_basic (basic-y-tiled-legacy)
[189.001377] Starting subtest: basic-y-tiled-legacy
[189.005540] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[189.191243] [074/165] (873s left) kms_addfb_basic (bo-too-small)
[189.652630] Starting subtest: bo-too-small
[189.656509] Subtest bo-too-small: SUCCESS (0.002s)
[189.817479] [075/165] (872s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[190.286463] Starting subtest: bo-too-small-due-to-tiling
[190.290988] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[190.430901] [076/165] (872s left) kms_addfb_basic (clobberred-modifier)
[190.847421] Starting subtest: clobberred-modifier
[190.851737] Subtest clobberred-modifier: SUCCESS (0.001s)
[191.047969] [077/165] (871s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[191.468970] Starting subtest: framebuffer-vs-set-tiling
[191.472655] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[191.676485] [078/165] (871s left) kms_addfb_basic (invalid-get-prop)
[192.097227] Starting subtest: invalid-get-prop
[192.100453] Subtest invalid-get-prop: SUCCESS (0.000s)
[192.302245] [079/165] (870s left) kms_addfb_basic (invalid-get-prop-any)
[192.727522] Starting subtest: invalid-get-prop-any
[192.731721] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[192.928504] [080/165] (870s left) kms_addfb_basic (invalid-set-prop)
[193.339960] Starting subtest: invalid-set-prop
[193.347547] Subtest invalid-set-prop: SUCCESS (0.000s)
[193.533634] [081/165] (869s left) kms_addfb_basic (invalid-set-prop-any)
[193.949453] Starting subtest: invalid-set-prop-any
[193.953222] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[194.170824] [082/165] (869s left) kms_addfb_basic (no-handle)
[194.587867] Starting subtest: no-handle
[194.592271] Subtest no-handle: SUCCESS (0.000s)
[194.794529] [083/165] (868s left) kms_addfb_basic (size-max)
[195.243919] Starting subtest: size-max
[195.248451] Subtest size-max: SUCCESS (0.001s)
[195.398700] [084/165] (868s left) kms_addfb_basic (small-bo)
[195.842862] Starting subtest: small-bo
[195.847349] Subtest small-bo: SUCCESS (0.000s)
[195.984905] [085/165] (867s left) kms_addfb_basic (tile-pitch-mismatch)
[196.403268] Starting subtest: tile-pitch-mismatch
[196.407491] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[196.593876] [086/165] (867s left) kms_addfb_basic (too-high)
[197.048665] Starting subtest: too-high
[197.052477] Subtest too-high: SUCCESS (0.004s)
[197.197578] [087/165] (866s left) kms_addfb_basic (too-wide)
[197.663832] Starting subtest: too-wide
[197.667839] Subtest too-wide: SUCCESS (0.000s)
[197.802348] [088/165] (865s left) kms_addfb_basic (unused-handle)
[198.215889] Starting subtest: unused-handle
[198.221793] Subtest unused-handle: SUCCESS (0.000s)
[198.402921] [089/165] (865s left) kms_addfb_basic (unused-modifier)
[198.806307] Starting subtest: unused-modifier
[198.810745] Subtest unused-modifier: SUCCESS (0.000s)
[199.031376] [090/165] (864s left) kms_addfb_basic (unused-offsets)
[199.463614] Starting subtest: unused-offsets
[199.467991] Subtest unused-offsets: SUCCESS (0.000s)
[199.659729] [091/165] (864s left) kms_addfb_basic (unused-pitches)
[200.070771] Starting subtest: unused-pitches
[200.075549] Subtest unused-pitches: SUCCESS (0.000s)
[200.254849] [092/165] (863s left) kms_busy (basic)
[200.712517] Starting subtest: basic
[200.721419] Starting dynamic subtest: flip
[202.206408] Dynamic subtest flip: SUCCESS (1.483s)
[202.257311] Starting dynamic subtest: modeset
[202.264963] Dynamic subtest modeset: SKIP (0.000s)
[202.268820] Subtest basic: SUCCESS (1.490s)
[202.489841] [093/165] (861s left) kms_prop_blob (basic)
[202.912442] Starting subtest: basic
[202.916450] Subtest basic: SUCCESS (0.001s)
[203.054195] [094/165] (861s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[203.503761] Starting subtest: basic-busy-flip-before-cursor-atomic
[203.515690] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.010s)
[203.655994] [095/165] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[204.099651] Starting subtest: basic-busy-flip-before-cursor-legacy
[205.396490] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.289s)
[205.687565] [096/165] (858s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[206.162274] Starting subtest: basic-flip-after-cursor-atomic
[206.171339] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[206.298304] [097/165] (858s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[206.757194] Starting subtest: basic-flip-after-cursor-legacy
[208.024289] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.267s)
[208.292188] [098/165] (856s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[208.760543] Starting subtest: basic-flip-after-cursor-varying-size
[210.054174] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.289s)
[210.354766] [099/165] (854s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[210.815857] Starting subtest: basic-flip-before-cursor-atomic
[210.825131] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[210.956473] [100/165] (853s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[211.400859] Starting subtest: basic-flip-before-cursor-legacy
[212.687727] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.286s)
[212.964565] [101/165] (852s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[213.432938] Starting subtest: basic-flip-before-cursor-varying-size
[214.717576] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.280s)
[214.980835] [102/165] (850s left) kms_dsc (dsc-basic)
[215.453869] Subtest dsc-basic: SKIP (0.000s)
[215.562910] [103/165] (849s left) kms_flip (basic-flip-vs-dpms)
[216.002942] Starting subtest: basic-flip-vs-dpms
[216.006798] Starting dynamic subtest: A-VGA1
[217.753801] Dynamic subtest A-VGA1: SUCCESS (1.747s)
[217.804469] Starting dynamic subtest: B-VGA1
[219.167746] Dynamic subtest B-VGA1: SUCCESS (1.410s)
[219.171413] Subtest basic-flip-vs-dpms: SUCCESS (3.163s)
[219.578834] [104/165] (845s left) kms_flip (basic-flip-vs-modeset)
[220.016420] Starting subtest: basic-flip-vs-modeset
[220.020631] Starting dynamic subtest: A-VGA1
[221.637440] Dynamic subtest A-VGA1: SUCCESS (1.612s)
[221.686197] Starting dynamic subtest: B-VGA1
[222.941781] Dynamic subtest B-VGA1: SUCCESS (1.302s)
[222.945762] Subtest basic-flip-vs-modeset: SUCCESS (2.921s)
[223.301999] [105/165] (842s left) kms_flip (basic-flip-vs-wf_vblank)
[223.741635] Starting subtest: basic-flip-vs-wf_vblank
[223.746383] Starting dynamic subtest: A-VGA1
[225.639627] Dynamic subtest A-VGA1: SUCCESS (1.893s)
[225.687419] Starting dynamic subtest: B-VGA1
[227.311148] Dynamic subtest B-VGA1: SUCCESS (1.672s)
[227.315314] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.572s)
[227.737429] [106/165] (837s left) kms_flip (basic-plain-flip)
[228.180843] Starting subtest: basic-plain-flip
[228.184707] Starting dynamic subtest: A-VGA1
[229.783367] Dynamic subtest A-VGA1: SUCCESS (1.603s)
[229.829507] Starting dynamic subtest: B-VGA1
[231.165182] Dynamic subtest B-VGA1: SUCCESS (1.379s)
[231.169135] Subtest basic-plain-flip: SUCCESS (2.990s)
[231.598179] [107/165] (833s left) kms_force_connector_basic (force-connector-state)
[232.093226] Starting subtest: force-connector-state
[232.356316] Subtest force-connector-state: SUCCESS (0.258s)
[232.802191] [108/165] (832s left) kms_force_connector_basic (force-edid)
[233.266995] Starting subtest: force-edid
[233.349997] Subtest force-edid: SUCCESS (0.085s)
[233.592273] [109/165] (832s left) kms_force_connector_basic (force-load-detect)
[234.064960] Starting subtest: force-load-detect
[234.415592] Subtest force-load-detect: SUCCESS (0.347s)
[234.806896] [110/165] (831s left) kms_force_connector_basic (prune-stale-modes)
[235.279788] Starting subtest: prune-stale-modes
[235.368314] Subtest prune-stale-modes: SUCCESS (0.084s)
[235.610402] [111/165] (830s left) kms_frontbuffer_tracking (basic)
[236.090424] Subtest basic: SKIP (0.000s)
[236.195736] [112/165] (829s left) kms_hdmi_inject (inject-audio)
[236.656147] Subtest inject-audio: SKIP (0.000s)
[236.908320] [113/165] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[237.604928] Starting subtest: compare-crc-sanitycheck-xr24
[237.616284] Starting dynamic subtest: pipe-A-VGA-1
[238.047689] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.412s)
[238.112290] Starting dynamic subtest: pipe-B-VGA-1
[238.553128] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.511s)
[238.561434] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.937s)
[238.897631] [114/165] (827s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[239.547802] Starting subtest: compare-crc-sanitycheck-nv12
[239.552500] Starting dynamic subtest: pipe-A-VGA-1
[239.561664] Dynamic subtest pipe-A-VGA-1: SKIP (0.002s)
[239.615494] Starting dynamic subtest: pipe-B-VGA-1
[239.622898] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[239.630326] Subtest compare-crc-sanitycheck-nv12: SKIP (0.016s)
[239.722499] [115/165] (826s left) kms_pipe_crc_basic (hang-read-crc)
[240.177877] Starting subtest: hang-read-crc
[240.181426] Starting dynamic subtest: pipe-A-VGA-1
[241.391791] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.212s)
[241.437999] Starting dynamic subtest: pipe-B-VGA-1
[242.693960] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.295s)
[242.698164] Subtest hang-read-crc: SUCCESS (2.518s)
[242.963477] [116/165] (823s left) kms_pipe_crc_basic (nonblocking-crc)
[243.443463] Starting subtest: nonblocking-crc
[243.452406] Starting dynamic subtest: pipe-A-VGA-1
[244.013872] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.563s)
[244.062534] Starting dynamic subtest: pipe-B-VGA-1
[244.687671] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.666s)
[244.692922] Subtest nonblocking-crc: SUCCESS (1.239s)
[244.953869] [117/165] (821s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[245.420169] Starting subtest: nonblocking-crc-frame-sequence
[245.424937] Starting dynamic subtest: pipe-A-VGA-1
[245.977081] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.551s)
[246.019555] Starting dynamic subtest: pipe-B-VGA-1
[246.659377] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.676s)
[246.663670] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.239s)
[246.919257] [118/165] (819s left) kms_pipe_crc_basic (read-crc)
[247.374591] Starting subtest: read-crc
[247.378963] Starting dynamic subtest: pipe-A-VGA-1
[247.862975] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.482s)
[247.903589] Starting dynamic subtest: pipe-B-VGA-1
[248.485232] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.617s)
[248.489288] Subtest read-crc: SUCCESS (1.111s)
[248.736520] [119/165] (818s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[249.197680] Starting subtest: read-crc-frame-sequence
[249.201352] Starting dynamic subtest: pipe-A-VGA-1
[249.696269] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.492s)
[249.752763] Starting dynamic subtest: pipe-B-VGA-1
[250.313385] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.611s)
[250.317617] Subtest read-crc-frame-sequence: SUCCESS (1.117s)
[250.566504] [120/165] (816s left) kms_pm_backlight (basic-brightness)
[251.014488] Subtest basic-brightness: SKIP (0.000s)
[251.122972] [121/165] (815s left) kms_pm_rpm (basic-pci-d3-state)
[263.065561] Subtest basic-pci-d3-state: SKIP (0.000s)
[263.166720] [122/165] (804s left) kms_pm_rpm (basic-rte)
[263.578722] Starting subtest: basic-rte
[275.061639] Subtest basic-rte: SKIP (11.452s)
[275.162561] [123/165] (792s left) kms_psr (primary_page_flip)
[275.575527] Subtest primary_page_flip: SKIP (0.000s)
[275.678388] [124/165] (791s left) kms_psr (cursor_plane_move)
[276.101339] Subtest cursor_plane_move: SKIP (0.000s)
[276.201775] [125/165] (791s left) kms_psr (sprite_plane_onoff)
[276.621764] Subtest sprite_plane_onoff: SKIP (0.000s)
[276.729485] [126/165] (790s left) kms_psr (primary_mmap_gtt)
[277.147721] Subtest primary_mmap_gtt: SKIP (0.000s)
[277.262834] [127/165] (790s left) kms_setmode (basic-clone-single-crtc)
[277.677421] Starting subtest: basic-clone-single-crtc
[277.688790] Subtest basic-clone-single-crtc: SKIP (0.001s)
[277.809191] [128/165] (789s left) i915_pm_rps (basic-api)
[278.242156] Subtest basic-api: SKIP (0.000s)
[278.347715] [129/165] (789s left) prime_self_import (basic-llseek-bad)
[278.757899] Starting subtest: basic-llseek-bad
[278.766494] Subtest basic-llseek-bad: SUCCESS (0.010s)
[278.909690] [130/165] (789s left) prime_self_import (basic-llseek-size)
[279.315738] Starting subtest: basic-llseek-size
[279.329758] Subtest basic-llseek-size: SUCCESS (0.017s)
[279.476643] [131/165] (788s left) prime_self_import (basic-with_fd_dup)
[279.869372] Starting subtest: basic-with_fd_dup
[279.890449] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[280.028208] [132/165] (788s left) prime_self_import (basic-with_one_bo)
[280.424477] Starting subtest: basic-with_one_bo
[280.441310] Subtest basic-with_one_bo: SUCCESS (0.019s)
[280.567664] [133/165] (787s left) prime_self_import (basic-with_one_bo_two_files)
[280.974870] Starting subtest: basic-with_one_bo_two_files
[280.987203] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[281.129619] [134/165] (787s left) prime_self_import (basic-with_two_bos)
[281.526869] Starting subtest: basic-with_two_bos
[281.544727] Subtest basic-with_two_bos: SUCCESS (0.018s)
[281.695265] [135/165] (786s left) prime_vgem (basic-fence-flip)
[282.131477] Starting subtest: basic-fence-flip
[282.764318] Subtest basic-fence-flip: SUCCESS (0.627s)
[282.948579] [136/165] (785s left) prime_vgem (basic-fence-mmap)
[283.383630] Starting subtest: basic-fence-mmap
[283.561531] Subtest basic-fence-mmap: SUCCESS (0.177s)
[283.719231] [137/165] (784s left) prime_vgem (basic-fence-read)
[284.151532] Starting subtest: basic-fence-read
[284.446398] Subtest basic-fence-read: SUCCESS (0.298s)
[284.600411] [138/165] (784s left) prime_vgem (basic-gtt)
[285.028536] Starting subtest: basic-gtt
[285.105270] Subtest basic-gtt: SUCCESS (0.076s)
[285.266648] [139/165] (783s left) prime_vgem (basic-read)
[285.704993] Starting subtest: basic-read
[285.834997] Subtest basic-read: SUCCESS (0.134s)
[285.986581] [140/165] (782s left) prime_vgem (basic-write)
[286.418102] Starting subtest: basic-write
[286.571462] Subtest basic-write: SUCCESS (0.152s)
[286.716747] [141/165] (782s left) vgem_basic (setversion)
[287.132939] Starting subtest: setversion
[287.140272] Subtest setversion: SUCCESS (0.000s)
[287.267465] [142/165] (781s left) vgem_basic (create)
[287.684589] Starting subtest: create
[287.688663] Subtest create: SUCCESS (0.002s)
[287.801603] [143/165] (781s left) vgem_basic (debugfs)
[288.219189] Starting subtest: debugfs
[288.222816] Subtest debugfs: SUCCESS (0.004s)
[288.359081] [144/165] (780s left) vgem_basic (dmabuf-export)
[288.768836] Starting subtest: dmabuf-export
[288.777892] Subtest dmabuf-export: SUCCESS (0.012s)
[288.921710] [145/165] (780s left) vgem_basic (dmabuf-fence)
[289.338716] Starting subtest: dmabuf-fence
[289.342837] Subtest dmabuf-fence: SUCCESS (0.004s)
[289.453817] [146/165] (779s left) vgem_basic (dmabuf-fence-before)
[289.870626] Starting subtest: dmabuf-fence-before
[289.875206] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[289.990678] [147/165] (779s left) vgem_basic (dmabuf-mmap)
[290.402485] Starting subtest: dmabuf-mmap
[290.481802] Subtest dmabuf-mmap: SUCCESS (0.081s)
[290.603590] [148/165] (778s left) vgem_basic (mmap)
[291.055912] Starting subtest: mmap
[291.118917] Subtest mmap: SUCCESS (0.062s)
[291.245433] [149/165] (778s left) vgem_basic (second-client)
[291.670900] Starting subtest: second-client
[291.707200] Subtest second-client: SUCCESS (0.034s)
[291.826973] [150/165] (777s left) vgem_basic (sysfs)
[292.238677] Starting subtest: sysfs
[292.244547] Subtest sysfs: SUCCESS (0.004s)
[292.358697] [151/165] (777s left) core_hotunplug (unbind-rebind)
[292.920149] Starting subtest: unbind-rebind
[297.421598] Subtest unbind-rebind: SUCCESS (4.493s)
[297.551359] [152/165] (772s left) vgem_basic (unload)
[297.999911] Starting subtest: unload
[327.404822] Subtest unload: SUCCESS (29.389s)
[327.659887] [153/165] (742s left) i915_module_load (reload)
[328.068718] Starting subtest: reload
[333.063897] Subtest reload: SUCCESS (4.992s)
[333.229416] [154/165] (736s left) gem_lmem_swapping (basic)
[334.148667] Subtest basic: SKIP (0.000s)
[334.272761] [155/165] (736s left) gem_lmem_swapping (parallel-random-engines)
[334.696798] Subtest parallel-random-engines: SKIP (0.000s)
[334.803354] [156/165] (735s left) gem_lmem_swapping (random-engines)
[335.222475] Subtest random-engines: SKIP (0.000s)
[335.320696] [157/165] (735s left) gem_lmem_swapping (verify-random)
[335.754754] Subtest verify-random: SKIP (0.000s)
[335.854496] [158/165] (734s left) i915_pm_rpm (module-reload)
[347.789489] Subtest module-reload: SKIP (0.000s)
[347.886145] [159/165] (722s left) i915_selftest (live)
[350.107995] Starting subtest: live
[350.111921] Starting dynamic subtest: sanitycheck
[352.454226] Dynamic subtest sanitycheck: SUCCESS (2.345s)
[352.485288] Starting dynamic subtest: uncore
[354.514836] Dynamic subtest uncore: SUCCESS (2.055s)
[354.546608] Starting dynamic subtest: workarounds
[356.591591] Dynamic subtest workarounds: SUCCESS (2.073s)
[356.627213] Starting dynamic subtest: gt_engines
[358.700638] Dynamic subtest gt_engines: SUCCESS (2.101s)
[358.739821] Starting dynamic subtest: gt_timelines
[369.794677] Dynamic subtest gt_timelines: SUCCESS (11.087s)
[369.827397] Starting dynamic subtest: gt_contexts
[371.922413] Dynamic subtest gt_contexts: SUCCESS (2.123s)
[371.953648] Starting dynamic subtest: gt_lrc
[373.984408] Dynamic subtest gt_lrc: SUCCESS (2.057s)
[374.019190] Starting dynamic subtest: gt_mocs
[376.040392] Dynamic subtest gt_mocs: SUCCESS (2.050s)
[376.073115] Starting dynamic subtest: gt_pm
[378.516189] Dynamic subtest gt_pm: SUCCESS (2.472s)
[378.548353] Starting dynamic subtest: gt_heartbeat
[380.705805] Dynamic subtest gt_heartbeat: SUCCESS (2.185s)
[380.738626] Starting dynamic subtest: gt_tlb
[382.804640] Dynamic subtest gt_tlb: SUCCESS (2.090s)
[382.842119] Starting dynamic subtest: requests
[387.536803] Dynamic subtest requests: SUCCESS (4.728s)
[387.569311] Starting dynamic subtest: migrate
[389.625614] Dynamic subtest migrate: SUCCESS (2.085s)
[389.662138] Starting dynamic subtest: active
[391.751407] Dynamic subtest active: SUCCESS (2.121s)
[391.785122] Starting dynamic subtest: objects
[394.848701] Dynamic subtest objects: SUCCESS (3.092s)
[394.888365] Starting dynamic subtest: mman
[406.652684] Dynamic subtest mman: SUCCESS (11.792s)
[406.683650] Starting dynamic subtest: dmabuf
[408.869218] Dynamic subtest dmabuf: SUCCESS (2.212s)
[408.903217] Starting dynamic subtest: vma
[410.990800] Dynamic subtest vma: SUCCESS (2.114s)
[411.028751] Starting dynamic subtest: coherency
[418.122629] Dynamic subtest coherency: SUCCESS (7.121s)
[418.158751] Starting dynamic subtest: gtt
[423.274584] Dynamic subtest gtt: SUCCESS (5.147s)
[423.307418] Starting dynamic subtest: gem
[425.439646] Dynamic subtest gem: SUCCESS (2.161s)
[425.471633] Starting dynamic subtest: evict
[427.520903] Dynamic subtest evict: SUCCESS (2.077s)
[427.554075] Starting dynamic subtest: hugepages
[429.598786] Dynamic subtest hugepages: SUCCESS (2.073s)
[429.634693] Starting dynamic subtest: gem_contexts
[431.696515] Dynamic subtest gem_contexts: SUCCESS (2.093s)
[431.733553] Starting dynamic subtest: client
[433.823633] Dynamic subtest client: SUCCESS (2.121s)
[433.861900] Starting dynamic subtest: gem_migrate
[435.885739] Dynamic subtest gem_migrate: SUCCESS (2.057s)
[435.918455] Starting dynamic subtest: reset
[438.532727] Dynamic subtest reset: SUCCESS (2.640s)
[438.570606] Starting dynamic subtest: memory_region
[440.608125] Dynamic subtest memory_region: SUCCESS (2.070s)
[440.645713] Starting dynamic subtest: hangcheck
[443.806655] Dynamic subtest hangcheck: SUCCESS (3.192s)
[443.839413] Starting dynamic subtest: execlists
[445.939433] Dynamic subtest execlists: SUCCESS (2.128s)
[445.972303] Starting dynamic subtest: ring_submission
[448.069775] Dynamic subtest ring_submission: SUCCESS (2.125s)
[448.107716] Starting dynamic subtest: perf
[450.168388] Dynamic subtest perf: SUCCESS (2.092s)
[450.205752] Starting dynamic subtest: slpc
[452.250290] Dynamic subtest slpc: SUCCESS (2.075s)
[452.288619] Starting dynamic subtest: guc
[454.359136] Dynamic subtest guc: SUCCESS (2.105s)
[454.403426] Starting dynamic subtest: guc_multi_lrc
[456.464495] Dynamic subtest guc_multi_lrc: SUCCESS (2.099s)
[456.498415] Starting dynamic subtest: guc_hang
[458.564471] Dynamic subtest guc_hang: SUCCESS (2.092s)
[458.602816] Starting dynamic subtest: late_gt_pm
[460.635537] Dynamic subtest late_gt_pm: SUCCESS (2.068s)
[460.639127] Subtest live: SUCCESS (110.477s)
[460.734205] [160/165] (610s left) dmabuf (all-tests)
[461.165122] Starting subtest: all-tests
[461.175821] Starting dynamic subtest: sanitycheck
[461.259640] Dynamic subtest sanitycheck: SUCCESS (0.094s)
[461.304878] Starting dynamic subtest: dma_fence
[461.479863] Dynamic subtest dma_fence: SUCCESS (0.217s)
[461.521792] Starting dynamic subtest: dma_fence_chain
[512.168873] Dynamic subtest dma_fence_chain: SUCCESS (50.660s)
[512.211548] Starting dynamic subtest: dma_fence_unwrap
[512.275511] Dynamic subtest dma_fence_unwrap: SUCCESS (0.102s)
[512.324385] Starting dynamic subtest: dma_resv
[512.384317] Dynamic subtest dma_resv: SUCCESS (0.103s)
[512.388527] Subtest all-tests: SUCCESS (51.199s)
[512.469473] [161/165] (558s left) i915_suspend (basic-s2idle-without-i915)
[512.876226] Starting subtest: basic-s2idle-without-i915
[534.722330] Subtest basic-s2idle-without-i915: SUCCESS (6.597s)
[536.943882] [162/165] (551s left) i915_suspend (basic-s3-without-i915)
[537.520769] Starting subtest: basic-s3-without-i915
[557.729890] Subtest basic-s3-without-i915: SUCCESS (4.484s)
[562.984066] [163/165] (546s left) gem_exec_suspend (basic-s0)
[563.489253] Starting subtest: basic-S0
[563.492568] Starting dynamic subtest: smem
[584.766032] Dynamic subtest smem: SUCCESS (6.175s)
[584.769782] Subtest basic-S0: SUCCESS (6.180s)
[587.090474] [164/165] (539s left) gem_exec_suspend (basic-s3)
[587.568793] Starting subtest: basic-S3
[587.572209] Starting dynamic subtest: smem
[609.918319] Dynamic subtest smem: SUCCESS (6.307s)
[609.921849] Subtest basic-S3: SUCCESS (6.313s)
[615.224055] [165/165] (532s left) kms_pipe_crc_basic (suspend-read-crc)
[615.692695] Starting subtest: suspend-read-crc
[615.696616] Starting dynamic subtest: pipe-A-VGA-1
[633.716502] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.466s)
[633.792107] Starting dynamic subtest: pipe-B-VGA-1
[651.741147] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.454s)
[651.745281] Subtest suspend-read-crc: SUCCESS (4.935s)
[655.010941] Closing watchdogs
Done.