[94.811625] Initializing watchdogs
[94.812373]   /dev/watchdog0
[94.840078] [001/165] (960s left) i915_module_load (load)
[95.256229] Starting subtest: load
[99.519550] Subtest load: SUCCESS (4.263s)
[99.629968] [002/165] (955s left) core_auth (basic-auth)
[100.505680] Starting subtest: basic-auth
[100.509767] Subtest basic-auth: SUCCESS (0.004s)
[100.645578] [003/165] (954s left) debugfs_test (read_all_entries)
[101.071963] Starting subtest: read_all_entries
[101.225753] Subtest read_all_entries: SUCCESS (0.150s)
[101.391275] [004/165] (954s left) debugfs_test (basic-hwmon)
[101.798426] Starting subtest: basic-hwmon
[101.804615] Subtest basic-hwmon: SKIP (0.000s)
[101.983967] [005/165] (953s left) fbdev (eof)
[102.383641] Starting subtest: eof
[102.388344] Subtest eof: SUCCESS (0.003s)
[102.509194] [006/165] (953s left) fbdev (info)
[102.902648] Starting subtest: info
[102.906567] Subtest info: SUCCESS (0.000s)
[103.024794] [007/165] (952s left) fbdev (nullptr)
[103.431664] Starting subtest: nullptr
[103.436756] Subtest nullptr: SUCCESS (0.000s)
[103.539921] [008/165] (952s left) fbdev (read)
[103.968075] Starting subtest: read
[104.283166] Subtest read: SUCCESS (0.318s)
[104.392162] [009/165] (951s left) fbdev (write)
[104.797729] Starting subtest: write
[104.974333] Subtest write: SUCCESS (0.176s)
[105.088088] [010/165] (950s left) gem_basic (bad-close)
[105.484184] Starting subtest: bad-close
[105.489878] Subtest bad-close: SUCCESS (0.000s)
[105.606377] [011/165] (950s left) gem_basic (create-close)
[106.012287] Starting subtest: create-close
[106.019312] Subtest create-close: SUCCESS (0.001s)
[106.142227] [012/165] (950s left) gem_basic (create-fd-close)
[106.544585] Starting subtest: create-fd-close
[106.552239] Subtest create-fd-close: SUCCESS (0.001s)
[106.674879] [013/165] (949s left) gem_busy (busy@all-engines)
[107.146666] Starting subtest: busy
[107.150723] Starting dynamic subtest: all-engines
[107.252701] Dynamic subtest all-engines: SUCCESS (0.108s)
[107.257229] Subtest busy: SUCCESS (0.110s)
[107.741816] [014/165] (948s left) gem_close_race (basic-process)
[108.208978] Starting subtest: basic-process
[108.383325] Subtest basic-process: SUCCESS (0.176s)
[108.664380] [015/165] (947s left) gem_close_race (basic-threads)
[109.142613] Starting subtest: basic-threads
[110.624646] Subtest basic-threads: SUCCESS (1.483s)
[110.964346] [016/165] (945s left) gem_ctx_create (basic)
[111.707680] Subtest basic: SKIP (0.000s)
[111.852280] [017/165] (944s left) gem_ctx_create (basic-files)
[112.440732] Subtest basic-files: SKIP (0.000s)
[112.575811] [018/165] (944s left) gem_ctx_exec (basic)
[113.169289] Subtest basic: SKIP (0.000s)
[113.327919] [019/165] (943s left) gem_exec_basic (basic)
[113.799948] Starting subtest: basic
[113.803635] Starting dynamic subtest: rcs0-smem
[113.806563] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[113.809631] Subtest basic: SUCCESS (0.007s)
[114.078980] [020/165] (942s left) gem_exec_create (basic)
[114.561690] Starting subtest: basic
[114.567710] Starting dynamic subtest: smem
[116.696110] Dynamic subtest smem: SUCCESS (2.137s)
[116.699272] Subtest basic: SUCCESS (2.139s)
[116.957758] [021/165] (940s left) gem_exec_fence (basic-busy)
[117.597217] Starting subtest: basic-busy
[117.604489] Starting dynamic subtest: rcs0
[117.631924] Dynamic subtest rcs0: SUCCESS (0.033s)
[117.636182] Subtest basic-busy: SUCCESS (0.036s)
[118.493176] [022/165] (938s left) gem_exec_fence (basic-wait)
[119.141722] Starting subtest: basic-wait
[119.145734] Starting dynamic subtest: rcs0
[119.170235] Dynamic subtest rcs0: SUCCESS (0.028s)
[119.173593] Subtest basic-wait: SUCCESS (0.030s)
[119.846877] [023/165] (937s left) gem_exec_fence (basic-await)
[120.501342] Starting subtest: basic-await
[120.504673] Starting dynamic subtest: rcs0
[120.618299] Dynamic subtest rcs0: SUCCESS (0.114s)
[120.621538] Subtest basic-await: SUCCESS (0.117s)
[121.309951] [024/165] (935s left) gem_exec_fence (nb-await)
[121.971575] Starting subtest: nb-await
[121.974693] Starting dynamic subtest: rcs0
[122.033814] Dynamic subtest rcs0: SUCCESS (0.060s)
[122.037271] Subtest nb-await: SUCCESS (0.063s)
[122.711845] [025/165] (934s left) gem_exec_gttfill (basic)
[123.179799] Starting subtest: basic
[136.825682] Subtest basic: SUCCESS (13.649s)
[137.146323] [026/165] (920s left) gem_exec_parallel (engines)
[138.013873] Starting subtest: engines
[138.017833] Starting dynamic subtest: basic
[141.683395] Dynamic subtest basic: SUCCESS (3.672s)
[141.733773] Starting dynamic subtest: contexts
[141.741286] Dynamic subtest contexts: SKIP (0.003s)
[141.775487] Starting dynamic subtest: fds
[141.781285] Dynamic subtest fds: SKIP (0.002s)
[141.814173] Starting dynamic subtest: userptr
[145.156733] Dynamic subtest userptr: SUCCESS (3.466s)
[145.159749] Subtest engines: SUCCESS (7.150s)
[145.437699] [027/165] (912s left) gem_exec_store (basic)
[145.903729] Starting subtest: basic
[145.952574] Subtest basic: SUCCESS (0.051s)
[146.239994] [028/165] (911s left) gem_flink_basic (bad-flink)
[146.640763] Starting subtest: bad-flink
[146.644702] Subtest bad-flink: SUCCESS (0.000s)
[146.765995] [029/165] (910s left) gem_flink_basic (bad-open)
[147.159726] Starting subtest: bad-open
[147.163700] Subtest bad-open: SUCCESS (0.000s)
[147.300157] [030/165] (910s left) gem_flink_basic (basic)
[147.696751] Starting subtest: basic
[147.700319] Subtest basic: SUCCESS (0.000s)
[147.835859] [031/165] (910s left) gem_flink_basic (double-flink)
[148.232775] Starting subtest: double-flink
[148.236394] Subtest double-flink: SUCCESS (0.001s)
[148.382799] [032/165] (909s left) gem_flink_basic (flink-lifetime)
[148.774562] Starting subtest: flink-lifetime
[148.784205] Subtest flink-lifetime: SUCCESS (0.007s)
[148.921216] [033/165] (909s left) gem_huc_copy (huc-copy)
[149.332605] Subtest huc-copy: SKIP (0.000s)
[149.439685] [034/165] (908s left) gem_linear_blits (basic)
[150.284492] Starting subtest: basic
[150.337207] Subtest basic: SUCCESS (0.051s)
[150.572884] [035/165] (907s left) gem_mmap (basic)
[151.255470] Starting subtest: basic
[151.271907] Subtest basic: SUCCESS (0.003s)
[151.401356] [036/165] (906s left) gem_mmap_gtt (basic)
[151.809554] Starting subtest: basic
[151.813380] Subtest basic: SUCCESS (0.004s)
[151.955836] [037/165] (906s left) gem_render_linear_blits (basic)
[152.373798] Starting subtest: basic
[152.506639] Subtest basic: SUCCESS (0.130s)
[152.622836] [038/165] (905s left) gem_render_tiled_blits (basic)
[153.032767] Starting subtest: basic
[153.175786] Subtest basic: SUCCESS (0.142s)
[153.291166] [039/165] (905s left) gem_ringfill (basic-all)
[153.761341] Starting subtest: basic-all
[154.956262] Subtest basic-all: SUCCESS (1.194s)
[155.103718] [040/165] (903s left) gem_softpin (allocator-basic)
[155.512294] Subtest allocator-basic: SKIP (0.000s)
[155.651152] [041/165] (903s left) gem_softpin (allocator-basic-reserve)
[156.059147] Subtest allocator-basic-reserve: SKIP (0.000s)
[156.185797] [042/165] (902s left) gem_softpin (safe-alignment)
[156.602775] Starting subtest: safe-alignment
[156.623231] Subtest safe-alignment: SUCCESS (0.026s)
[156.770143] [043/165] (902s left) gem_sync (basic-all)
[157.235282] Starting subtest: basic-all
[159.558602] Subtest basic-all: SUCCESS (2.324s)
[159.835195] [044/165] (899s left) gem_sync (basic-each)
[160.303578] Starting subtest: basic-each
[162.610679] Subtest basic-each: SUCCESS (2.307s)
[162.887254] [045/165] (896s left) gem_tiled_blits (basic)
[163.555550] Starting subtest: basic
[163.652881] Subtest basic: SUCCESS (0.098s)
[163.873739] [046/165] (895s left) gem_tiled_fence_blits (basic)
[164.885624] Starting subtest: basic
[164.958742] Subtest basic: SUCCESS (0.074s)
[165.176277] [047/165] (894s left) gem_tiled_pread_basic
[167.654313] [048/165] (891s left) gem_wait (busy@all-engines)
[168.158551] Starting subtest: busy
[168.162582] Starting dynamic subtest: all-engines
[168.686843] Dynamic subtest all-engines: SUCCESS (0.532s)
[168.690100] Subtest busy: SUCCESS (0.535s)
[169.087852] [049/165] (890s left) gem_wait (wait@all-engines)
[169.599643] Starting subtest: wait
[169.603571] Starting dynamic subtest: all-engines
[170.645143] Dynamic subtest all-engines: SUCCESS (1.046s)
[170.651591] Subtest wait: SUCCESS (1.048s)
[171.054811] [050/165] (888s left) i915_getparams_basic (basic-eu-total)
[171.464599] Starting subtest: basic-eu-total
[171.470525] Subtest basic-eu-total: SUCCESS (0.000s)
[171.602992] [051/165] (887s left) i915_getparams_basic (basic-subslice-total)
[172.009530] Starting subtest: basic-subslice-total
[172.018138] Subtest basic-subslice-total: SUCCESS (0.000s)
[172.156500] [052/165] (887s left) i915_hangman (error-state-basic)
[172.574580] Starting subtest: error-state-basic
[172.931843] Subtest error-state-basic: SUCCESS (0.345s)
[173.046424] [053/165] (886s left) i915_pciid
[173.588219] [054/165] (886s left) kms_addfb_basic (addfb25-4-tiled)
[174.070879] Starting subtest: addfb25-4-tiled
[174.074858] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[174.205352] [055/165] (885s left) kms_addfb_basic (addfb25-bad-modifier)
[174.617956] Starting subtest: addfb25-bad-modifier
[174.621889] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[174.824754] [056/165] (885s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[175.232115] Starting subtest: addfb25-framebuffer-vs-set-tiling
[175.235551] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[175.442743] [057/165] (884s left) kms_addfb_basic (addfb25-modifier-no-flag)
[175.850519] Starting subtest: addfb25-modifier-no-flag
[175.854152] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[176.063601] [058/165] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[176.465866] Starting subtest: addfb25-x-tiled-legacy
[176.469555] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[176.671795] [059/165] (883s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[177.091107] Starting subtest: addfb25-x-tiled-mismatch-legacy
[177.094307] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[177.283646] [060/165] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[177.738531] Starting subtest: addfb25-yf-tiled-legacy
[177.742653] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[177.893298] [061/165] (882s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[178.354596] Starting subtest: addfb25-y-tiled-legacy
[178.357969] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[178.488405] [062/165] (882s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[178.936861] Starting subtest: addfb25-y-tiled-small-legacy
[178.944419] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[179.072167] [063/165] (881s left) kms_addfb_basic (bad-pitch-0)
[179.486305] Starting subtest: bad-pitch-0
[179.490655] Subtest bad-pitch-0: SUCCESS (0.000s)
[179.688568] [064/165] (881s left) kms_addfb_basic (bad-pitch-1024)
[180.098349] Starting subtest: bad-pitch-1024
[180.102086] Subtest bad-pitch-1024: SUCCESS (0.000s)
[180.305805] [065/165] (880s left) kms_addfb_basic (bad-pitch-128)
[180.706236] Starting subtest: bad-pitch-128
[180.709704] Subtest bad-pitch-128: SUCCESS (0.000s)
[180.947795] [066/165] (879s left) kms_addfb_basic (bad-pitch-256)
[181.347310] Starting subtest: bad-pitch-256
[181.351217] Subtest bad-pitch-256: SUCCESS (0.000s)
[181.554559] [067/165] (879s left) kms_addfb_basic (bad-pitch-32)
[181.980280] Starting subtest: bad-pitch-32
[181.983548] Subtest bad-pitch-32: SUCCESS (0.000s)
[182.193473] [068/165] (878s left) kms_addfb_basic (bad-pitch-63)
[182.599138] Starting subtest: bad-pitch-63
[182.602760] Subtest bad-pitch-63: SUCCESS (0.000s)
[182.790831] [069/165] (878s left) kms_addfb_basic (bad-pitch-65536)
[183.190816] Starting subtest: bad-pitch-65536
[183.194556] Subtest bad-pitch-65536: SUCCESS (0.002s)
[183.409909] [070/165] (877s left) kms_addfb_basic (bad-pitch-999)
[183.837564] Starting subtest: bad-pitch-999
[183.841067] Subtest bad-pitch-999: SUCCESS (0.000s)
[184.040716] [071/165] (877s left) kms_addfb_basic (basic)
[184.456872] Starting subtest: basic
[184.460725] Subtest basic: SUCCESS (0.000s)
[184.646780] [072/165] (876s left) kms_addfb_basic (basic-x-tiled-legacy)
[185.050834] Starting subtest: basic-x-tiled-legacy
[185.054827] Subtest basic-x-tiled-legacy: SUCCESS (0.001s)
[185.230649] [073/165] (876s left) kms_addfb_basic (basic-y-tiled-legacy)
[185.643113] Starting subtest: basic-y-tiled-legacy
[185.646089] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[185.854739] [074/165] (875s left) kms_addfb_basic (bo-too-small)
[186.300201] Starting subtest: bo-too-small
[186.304915] Subtest bo-too-small: SUCCESS (0.002s)
[186.438495] [075/165] (875s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[186.886194] Starting subtest: bo-too-small-due-to-tiling
[186.889280] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[187.051814] [076/165] (874s left) kms_addfb_basic (clobberred-modifier)
[187.450464] Starting subtest: clobberred-modifier
[187.454557] Subtest clobberred-modifier: SUCCESS (0.001s)
[187.651664] [077/165] (874s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[188.069657] Starting subtest: framebuffer-vs-set-tiling
[188.072834] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[188.292232] [078/165] (873s left) kms_addfb_basic (invalid-get-prop)
[188.694888] Starting subtest: invalid-get-prop
[188.699508] Subtest invalid-get-prop: SUCCESS (0.000s)
[188.889918] [079/165] (873s left) kms_addfb_basic (invalid-get-prop-any)
[189.289377] Starting subtest: invalid-get-prop-any
[189.293718] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[189.473706] [080/165] (872s left) kms_addfb_basic (invalid-set-prop)
[189.877390] Starting subtest: invalid-set-prop
[189.881523] Subtest invalid-set-prop: SUCCESS (0.000s)
[190.057194] [081/165] (872s left) kms_addfb_basic (invalid-set-prop-any)
[190.462671] Starting subtest: invalid-set-prop-any
[190.467272] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[190.657640] [082/165] (871s left) kms_addfb_basic (no-handle)
[191.063511] Starting subtest: no-handle
[191.067337] Subtest no-handle: SUCCESS (0.000s)
[191.255946] [083/165] (871s left) kms_addfb_basic (size-max)
[191.706502] Starting subtest: size-max
[191.709645] Subtest size-max: SUCCESS (0.001s)
[191.857219] [084/165] (870s left) kms_addfb_basic (small-bo)
[192.301672] Starting subtest: small-bo
[192.305492] Subtest small-bo: SUCCESS (0.000s)
[192.457677] [085/165] (870s left) kms_addfb_basic (tile-pitch-mismatch)
[192.869698] Starting subtest: tile-pitch-mismatch
[192.874405] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[193.057607] [086/165] (869s left) kms_addfb_basic (too-high)
[193.518573] Starting subtest: too-high
[193.522785] Subtest too-high: SUCCESS (0.005s)
[193.671982] [087/165] (869s left) kms_addfb_basic (too-wide)
[194.120754] Starting subtest: too-wide
[194.124708] Subtest too-wide: SUCCESS (0.000s)
[194.255876] [088/165] (868s left) kms_addfb_basic (unused-handle)
[194.659526] Starting subtest: unused-handle
[194.662728] Subtest unused-handle: SUCCESS (0.000s)
[194.862247] [089/165] (868s left) kms_addfb_basic (unused-modifier)
[195.259442] Starting subtest: unused-modifier
[195.263726] Subtest unused-modifier: SUCCESS (0.001s)
[195.474763] [090/165] (867s left) kms_addfb_basic (unused-offsets)
[195.876246] Starting subtest: unused-offsets
[195.880471] Subtest unused-offsets: SUCCESS (0.000s)
[196.056307] [091/165] (867s left) kms_addfb_basic (unused-pitches)
[196.463459] Starting subtest: unused-pitches
[196.467440] Subtest unused-pitches: SUCCESS (0.000s)
[196.638493] [092/165] (866s left) kms_busy (basic)
[197.100970] Starting subtest: basic
[197.105814] Starting dynamic subtest: flip
[198.488323] Dynamic subtest flip: SUCCESS (1.384s)
[198.537787] Starting dynamic subtest: modeset
[198.544764] Dynamic subtest modeset: SKIP (0.000s)
[198.548588] Subtest basic: SUCCESS (1.391s)
[198.749361] [093/165] (864s left) kms_prop_blob (basic)
[199.168215] Starting subtest: basic
[199.171753] Subtest basic: SUCCESS (0.000s)
[199.302441] [094/165] (864s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[199.754782] Starting subtest: basic-busy-flip-before-cursor-atomic
[199.767326] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.011s)
[199.904750] [095/165] (863s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[200.352393] Starting subtest: basic-busy-flip-before-cursor-legacy
[201.623758] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.274s)
[201.895339] [096/165] (861s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[202.346106] Starting subtest: basic-flip-after-cursor-atomic
[202.353671] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[202.486271] [097/165] (861s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[202.928284] Starting subtest: basic-flip-after-cursor-legacy
[204.186586] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.255s)
[204.459510] [098/165] (859s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[204.940762] Starting subtest: basic-flip-after-cursor-varying-size
[206.194589] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.255s)
[206.460648] [099/165] (857s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[206.916452] Starting subtest: basic-flip-before-cursor-atomic
[206.923764] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[207.060944] [100/165] (856s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[207.516711] Starting subtest: basic-flip-before-cursor-legacy
[208.771845] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.252s)
[209.038329] [101/165] (855s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[209.477268] Starting subtest: basic-flip-before-cursor-varying-size
[210.736564] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.256s)
[211.009472] [102/165] (853s left) kms_dsc (dsc-basic)
[211.484428] Subtest dsc-basic: SKIP (0.000s)
[211.592113] [103/165] (852s left) kms_flip (basic-flip-vs-dpms)
[212.035542] Starting subtest: basic-flip-vs-dpms
[212.039708] Starting dynamic subtest: A-VGA1
[213.737648] Dynamic subtest A-VGA1: SUCCESS (1.704s)
[213.782694] Starting dynamic subtest: B-VGA1
[215.078116] Dynamic subtest B-VGA1: SUCCESS (1.337s)
[215.081560] Subtest basic-flip-vs-dpms: SUCCESS (3.047s)
[215.491706] [104/165] (848s left) kms_flip (basic-flip-vs-modeset)
[215.949129] Starting subtest: basic-flip-vs-modeset
[215.953455] Starting dynamic subtest: A-VGA1
[217.562602] Dynamic subtest A-VGA1: SUCCESS (1.608s)
[217.609426] Starting dynamic subtest: B-VGA1
[218.878491] Dynamic subtest B-VGA1: SUCCESS (1.316s)
[218.887309] Subtest basic-flip-vs-modeset: SUCCESS (2.932s)
[219.276634] [105/165] (845s left) kms_flip (basic-flip-vs-wf_vblank)
[219.705418] Starting subtest: basic-flip-vs-wf_vblank
[219.710133] Starting dynamic subtest: A-VGA1
[221.582769] Dynamic subtest A-VGA1: SUCCESS (1.873s)
[221.621552] Starting dynamic subtest: B-VGA1
[223.265710] Dynamic subtest B-VGA1: SUCCESS (1.679s)
[223.269352] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.560s)
[223.708155] [106/165] (840s left) kms_flip (basic-plain-flip)
[224.164212] Starting subtest: basic-plain-flip
[224.167430] Starting dynamic subtest: A-VGA1
[225.774111] Dynamic subtest A-VGA1: SUCCESS (1.607s)
[225.813106] Starting dynamic subtest: B-VGA1
[227.173697] Dynamic subtest B-VGA1: SUCCESS (1.396s)
[227.177152] Subtest basic-plain-flip: SUCCESS (3.011s)
[227.619261] [107/165] (837s left) kms_force_connector_basic (force-connector-state)
[228.086699] Starting subtest: force-connector-state
[228.419602] Subtest force-connector-state: SUCCESS (0.329s)
[228.968902] [108/165] (835s left) kms_force_connector_basic (force-edid)
[229.672560] Starting subtest: force-edid
[229.800109] Subtest force-edid: SUCCESS (0.125s)
[230.104168] [109/165] (834s left) kms_force_connector_basic (force-load-detect)
[230.786800] Starting subtest: force-load-detect
[231.197899] Subtest force-load-detect: SUCCESS (0.416s)
[231.668736] [110/165] (833s left) kms_force_connector_basic (prune-stale-modes)
[232.363355] Starting subtest: prune-stale-modes
[232.513332] Subtest prune-stale-modes: SUCCESS (0.145s)
[232.780287] [111/165] (832s left) kms_frontbuffer_tracking (basic)
[233.249686] Subtest basic: SKIP (0.000s)
[233.351380] [112/165] (831s left) kms_hdmi_inject (inject-audio)
[233.752140] Subtest inject-audio: SKIP (0.000s)
[233.865534] [113/165] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[234.304320] Starting subtest: compare-crc-sanitycheck-xr24
[234.308943] Starting dynamic subtest: pipe-A-VGA-1
[234.685348] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.366s)
[234.735441] Starting dynamic subtest: pipe-B-VGA-1
[235.165743] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.483s)
[235.169704] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.860s)
[235.434855] [114/165] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[235.893961] Starting subtest: compare-crc-sanitycheck-nv12
[235.901625] Starting dynamic subtest: pipe-A-VGA-1
[235.907827] Dynamic subtest pipe-A-VGA-1: SKIP (0.002s)
[235.944445] Starting dynamic subtest: pipe-B-VGA-1
[235.949901] Dynamic subtest pipe-B-VGA-1: SKIP (0.002s)
[235.955500] Subtest compare-crc-sanitycheck-nv12: SKIP (0.016s)
[236.051344] [115/165] (829s left) kms_pipe_crc_basic (hang-read-crc)
[236.499559] Starting subtest: hang-read-crc
[236.506308] Starting dynamic subtest: pipe-A-VGA-1
[237.685743] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.188s)
[237.739836] Starting dynamic subtest: pipe-B-VGA-1
[238.999425] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.307s)
[239.003623] Subtest hang-read-crc: SUCCESS (2.505s)
[239.259391] [116/165] (826s left) kms_pipe_crc_basic (nonblocking-crc)
[239.701939] Starting subtest: nonblocking-crc
[239.710453] Starting dynamic subtest: pipe-A-VGA-1
[240.302354] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.595s)
[240.345537] Starting dynamic subtest: pipe-B-VGA-1
[240.993363] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.684s)
[240.996541] Subtest nonblocking-crc: SUCCESS (1.293s)
[241.270805] [117/165] (824s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[241.718654] Starting subtest: nonblocking-crc-frame-sequence
[241.722946] Starting dynamic subtest: pipe-A-VGA-1
[242.289858] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.565s)
[242.349456] Starting dynamic subtest: pipe-B-VGA-1
[242.955275] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.660s)
[242.959499] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.237s)
[243.206259] [118/165] (822s left) kms_pipe_crc_basic (read-crc)
[243.652425] Starting subtest: read-crc
[243.656765] Starting dynamic subtest: pipe-A-VGA-1
[244.150093] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.499s)
[244.193513] Starting dynamic subtest: pipe-B-VGA-1
[244.753753] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.595s)
[244.759107] Subtest read-crc: SUCCESS (1.106s)
[245.006607] [119/165] (820s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[245.448833] Starting subtest: read-crc-frame-sequence
[245.453780] Starting dynamic subtest: pipe-A-VGA-1
[245.934788] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.482s)
[245.991441] Starting dynamic subtest: pipe-B-VGA-1
[246.547606] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.603s)
[246.551868] Subtest read-crc-frame-sequence: SUCCESS (1.099s)
[246.801924] [120/165] (819s left) kms_pm_backlight (basic-brightness)
[247.261132] Subtest basic-brightness: SKIP (0.000s)
[247.398250] [121/165] (818s left) kms_pm_rpm (basic-pci-d3-state)
[259.289770] Subtest basic-pci-d3-state: SKIP (0.000s)
[259.390223] [122/165] (806s left) kms_pm_rpm (basic-rte)
[259.780435] Starting subtest: basic-rte
[271.270297] Subtest basic-rte: SKIP (11.471s)
[271.374295] [123/165] (794s left) kms_psr (psr_primary_page_flip)
[271.814222] Subtest psr_primary_page_flip: SKIP (0.000s)
[271.923087] [124/165] (794s left) kms_psr (psr_cursor_plane_move)
[272.382493] Subtest psr_cursor_plane_move: SKIP (0.000s)
[272.490749] [125/165] (793s left) kms_psr (psr_sprite_plane_onoff)
[272.949801] Subtest psr_sprite_plane_onoff: SKIP (0.000s)
[273.089662] [126/165] (793s left) kms_psr (psr_primary_mmap_gtt)
[273.532721] Subtest psr_primary_mmap_gtt: SKIP (0.000s)
[273.639503] [127/165] (792s left) kms_setmode (basic-clone-single-crtc)
[274.052607] Starting subtest: basic-clone-single-crtc
[274.061676] Subtest basic-clone-single-crtc: SKIP (0.001s)
[274.183528] [128/165] (792s left) i915_pm_rps (basic-api)
[274.595512] Subtest basic-api: SKIP (0.000s)
[274.706636] [129/165] (792s left) prime_self_import (basic-llseek-bad)
[275.093152] Starting subtest: basic-llseek-bad
[275.107633] Subtest basic-llseek-bad: SUCCESS (0.011s)
[275.249873] [130/165] (791s left) prime_self_import (basic-llseek-size)
[275.642562] Starting subtest: basic-llseek-size
[275.663519] Subtest basic-llseek-size: SUCCESS (0.021s)
[275.799513] [131/165] (791s left) prime_self_import (basic-with_fd_dup)
[276.196619] Starting subtest: basic-with_fd_dup
[276.212659] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[276.351891] [132/165] (790s left) prime_self_import (basic-with_one_bo)
[276.738667] Starting subtest: basic-with_one_bo
[276.752582] Subtest basic-with_one_bo: SUCCESS (0.016s)
[276.890699] [133/165] (790s left) prime_self_import (basic-with_one_bo_two_files)
[277.280847] Starting subtest: basic-with_one_bo_two_files
[277.295639] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[277.452613] [134/165] (789s left) prime_self_import (basic-with_two_bos)
[277.836173] Starting subtest: basic-with_two_bos
[277.853379] Subtest basic-with_two_bos: SUCCESS (0.016s)
[277.985974] [135/165] (789s left) prime_vgem (basic-fence-flip)
[278.399084] Starting subtest: basic-fence-flip
[279.015228] Subtest basic-fence-flip: SUCCESS (0.615s)
[279.188715] [136/165] (788s left) prime_vgem (basic-fence-mmap)
[279.618890] Starting subtest: basic-fence-mmap
[279.811516] Subtest basic-fence-mmap: SUCCESS (0.191s)
[279.954087] [137/165] (787s left) prime_vgem (basic-fence-read)
[280.368392] Starting subtest: basic-fence-read
[280.676160] Subtest basic-fence-read: SUCCESS (0.307s)
[280.820466] [138/165] (786s left) prime_vgem (basic-gtt)
[281.250577] Starting subtest: basic-gtt
[281.324156] Subtest basic-gtt: SUCCESS (0.073s)
[281.485479] [139/165] (786s left) prime_vgem (basic-read)
[281.922466] Starting subtest: basic-read
[282.048143] Subtest basic-read: SUCCESS (0.130s)
[282.201463] [140/165] (785s left) prime_vgem (basic-write)
[282.616244] Starting subtest: basic-write
[282.756826] Subtest basic-write: SUCCESS (0.141s)
[282.902553] [141/165] (784s left) vgem_basic (setversion)
[283.300731] Starting subtest: setversion
[283.307848] Subtest setversion: SUCCESS (0.000s)
[283.419737] [142/165] (784s left) vgem_basic (create)
[283.818787] Starting subtest: create
[283.822768] Subtest create: SUCCESS (0.003s)
[283.935477] [143/165] (784s left) vgem_basic (debugfs)
[284.349277] Starting subtest: debugfs
[284.353149] Subtest debugfs: SUCCESS (0.003s)
[284.485363] [144/165] (783s left) vgem_basic (dmabuf-export)
[284.885793] Starting subtest: dmabuf-export
[284.894810] Subtest dmabuf-export: SUCCESS (0.011s)
[285.034329] [145/165] (783s left) vgem_basic (dmabuf-fence)
[285.433517] Starting subtest: dmabuf-fence
[285.437603] Subtest dmabuf-fence: SUCCESS (0.005s)
[285.549734] [146/165] (782s left) vgem_basic (dmabuf-fence-before)
[285.952703] Starting subtest: dmabuf-fence-before
[285.956616] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[286.068773] [147/165] (782s left) vgem_basic (dmabuf-mmap)
[286.465767] Starting subtest: dmabuf-mmap
[286.551437] Subtest dmabuf-mmap: SUCCESS (0.086s)
[286.670354] [148/165] (781s left) vgem_basic (mmap)
[287.083725] Starting subtest: mmap
[287.137153] Subtest mmap: SUCCESS (0.055s)
[287.266708] [149/165] (781s left) vgem_basic (second-client)
[287.699507] Starting subtest: second-client
[287.732764] Subtest second-client: SUCCESS (0.033s)
[287.852679] [150/165] (780s left) vgem_basic (sysfs)
[288.267433] Starting subtest: sysfs
[288.271603] Subtest sysfs: SUCCESS (0.005s)
[288.384656] [151/165] (780s left) core_hotunplug (unbind-rebind)
[288.931597] Starting subtest: unbind-rebind
[293.408277] Subtest unbind-rebind: SUCCESS (4.476s)
[293.514702] [152/165] (775s left) vgem_basic (unload)
[293.928606] Starting subtest: unload
[323.234952] Subtest unload: SUCCESS (29.321s)
[323.483790] [153/165] (745s left) i915_module_load (reload)
[323.886478] Starting subtest: reload
[328.747148] Subtest reload: SUCCESS (4.858s)
[328.908770] [154/165] (740s left) gem_lmem_swapping (basic)
[329.641213] Subtest basic: SKIP (0.000s)
[329.809323] [155/165] (739s left) gem_lmem_swapping (parallel-random-engines)
[330.257274] Subtest parallel-random-engines: SKIP (0.000s)
[330.365699] [156/165] (738s left) gem_lmem_swapping (random-engines)
[330.779189] Subtest random-engines: SKIP (0.000s)
[330.881139] [157/165] (738s left) gem_lmem_swapping (verify-random)
[331.305715] Subtest verify-random: SKIP (0.000s)
[331.398735] [158/165] (738s left) i915_pm_rpm (module-reload)
[343.312553] Subtest module-reload: SKIP (0.000s)
[343.402671] [159/165] (726s left) i915_selftest (live)
[345.485491] Starting subtest: live
[345.488700] Starting dynamic subtest: sanitycheck
[347.943704] Dynamic subtest sanitycheck: SUCCESS (2.457s)
[347.982275] Starting dynamic subtest: uncore
[350.086728] Dynamic subtest uncore: SUCCESS (2.140s)
[350.118135] Starting dynamic subtest: workarounds
[352.150509] Dynamic subtest workarounds: SUCCESS (2.063s)
[352.189870] Starting dynamic subtest: gt_engines
[354.224638] Dynamic subtest gt_engines: SUCCESS (2.073s)
[354.254800] Starting dynamic subtest: gt_timelines
[365.216804] Dynamic subtest gt_timelines: SUCCESS (10.993s)
[365.255239] Starting dynamic subtest: gt_contexts
[367.316315] Dynamic subtest gt_contexts: SUCCESS (2.096s)
[367.356580] Starting dynamic subtest: gt_lrc
[369.381199] Dynamic subtest gt_lrc: SUCCESS (2.062s)
[369.412130] Starting dynamic subtest: gt_mocs
[371.385271] Dynamic subtest gt_mocs: SUCCESS (2.002s)
[371.418486] Starting dynamic subtest: gt_pm
[373.878607] Dynamic subtest gt_pm: SUCCESS (2.489s)
[373.918918] Starting dynamic subtest: gt_heartbeat
[376.019718] Dynamic subtest gt_heartbeat: SUCCESS (2.141s)
[376.050620] Starting dynamic subtest: gt_tlb
[378.128629] Dynamic subtest gt_tlb: SUCCESS (2.104s)
[378.176365] Starting dynamic subtest: requests
[382.833792] Dynamic subtest requests: SUCCESS (4.706s)
[382.864350] Starting dynamic subtest: migrate
[384.910112] Dynamic subtest migrate: SUCCESS (2.074s)
[384.940341] Starting dynamic subtest: active
[387.000954] Dynamic subtest active: SUCCESS (2.089s)
[387.031525] Starting dynamic subtest: objects
[390.081450] Dynamic subtest objects: SUCCESS (3.079s)
[390.113175] Starting dynamic subtest: mman
[401.704179] Dynamic subtest mman: SUCCESS (11.625s)
[401.744210] Starting dynamic subtest: dmabuf
[403.885396] Dynamic subtest dmabuf: SUCCESS (2.178s)
[403.924915] Starting dynamic subtest: vma
[406.052568] Dynamic subtest vma: SUCCESS (2.163s)
[406.094263] Starting dynamic subtest: coherency
[413.086720] Dynamic subtest coherency: SUCCESS (7.033s)
[413.117596] Starting dynamic subtest: gtt
[418.647110] Dynamic subtest gtt: SUCCESS (5.561s)
[418.684996] Starting dynamic subtest: gem
[420.845269] Dynamic subtest gem: SUCCESS (2.196s)
[420.884478] Starting dynamic subtest: evict
[422.916505] Dynamic subtest evict: SUCCESS (2.068s)
[422.955691] Starting dynamic subtest: hugepages
[424.957573] Dynamic subtest hugepages: SUCCESS (2.039s)
[424.988291] Starting dynamic subtest: gem_contexts
[426.994402] Dynamic subtest gem_contexts: SUCCESS (2.033s)
[427.034232] Starting dynamic subtest: client
[429.071604] Dynamic subtest client: SUCCESS (2.072s)
[429.112439] Starting dynamic subtest: gem_migrate
[431.145747] Dynamic subtest gem_migrate: SUCCESS (2.073s)
[431.185560] Starting dynamic subtest: reset
[433.750725] Dynamic subtest reset: SUCCESS (2.603s)
[433.783301] Starting dynamic subtest: memory_region
[435.832908] Dynamic subtest memory_region: SUCCESS (2.076s)
[435.873480] Starting dynamic subtest: hangcheck
[439.017393] Dynamic subtest hangcheck: SUCCESS (3.183s)
[439.048445] Starting dynamic subtest: execlists
[441.083185] Dynamic subtest execlists: SUCCESS (2.064s)
[441.114354] Starting dynamic subtest: ring_submission
[443.183456] Dynamic subtest ring_submission: SUCCESS (2.097s)
[443.223384] Starting dynamic subtest: perf
[445.313594] Dynamic subtest perf: SUCCESS (2.126s)
[445.344420] Starting dynamic subtest: slpc
[447.367207] Dynamic subtest slpc: SUCCESS (2.052s)
[447.397812] Starting dynamic subtest: guc
[449.443884] Dynamic subtest guc: SUCCESS (2.074s)
[449.475961] Starting dynamic subtest: guc_multi_lrc
[451.566977] Dynamic subtest guc_multi_lrc: SUCCESS (2.121s)
[451.602302] Starting dynamic subtest: guc_hang
[453.638950] Dynamic subtest guc_hang: SUCCESS (2.068s)
[453.669988] Starting dynamic subtest: late_gt_pm
[455.706145] Dynamic subtest late_gt_pm: SUCCESS (2.064s)
[455.710310] Subtest live: SUCCESS (110.278s)
[455.807472] [160/165] (613s left) dmabuf (all-tests)
[456.321439] Starting subtest: all-tests
[456.324784] Starting dynamic subtest: sanitycheck
[456.421448] Dynamic subtest sanitycheck: SUCCESS (0.097s)
[456.465894] Starting dynamic subtest: dma_fence
[456.638674] Dynamic subtest dma_fence: SUCCESS (0.214s)
[456.674278] Starting dynamic subtest: dma_fence_chain
[509.111220] Dynamic subtest dma_fence_chain: SUCCESS (52.494s)
[509.150888] Starting dynamic subtest: dma_fence_unwrap
[509.204786] Dynamic subtest dma_fence_unwrap: SUCCESS (0.089s)
[509.242336] Starting dynamic subtest: dma_resv
[509.309118] Dynamic subtest dma_resv: SUCCESS (0.100s)
[509.312444] Subtest all-tests: SUCCESS (53.017s)
[509.419915] [161/165] (560s left) i915_suspend (basic-s2idle-without-i915)
[509.840902] Starting subtest: basic-s2idle-without-i915
[531.490898] Subtest basic-s2idle-without-i915: SUCCESS (6.491s)
[533.731787] [162/165] (553s left) i915_suspend (basic-s3-without-i915)
[534.228315] Starting subtest: basic-s3-without-i915
[554.695915] Subtest basic-s3-without-i915: SUCCESS (4.486s)
[559.947314] [163/165] (548s left) gem_exec_suspend (basic-s0)
[560.456290] Starting subtest: basic-S0
[560.460709] Starting dynamic subtest: smem
[581.626203] Dynamic subtest smem: SUCCESS (5.963s)
[581.630004] Subtest basic-S0: SUCCESS (5.969s)
[583.936136] [164/165] (541s left) gem_exec_suspend (basic-s3)
[584.439592] Starting subtest: basic-S3
[584.444499] Starting dynamic subtest: smem
[606.855334] Dynamic subtest smem: SUCCESS (6.086s)
[606.858296] Subtest basic-S3: SUCCESS (6.092s)
[611.147605] [165/165] (534s left) kms_pipe_crc_basic (suspend-read-crc)
[611.616517] Starting subtest: suspend-read-crc
[611.620597] Starting dynamic subtest: pipe-A-VGA-1
[629.634312] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.291s)
[629.691249] Starting dynamic subtest: pipe-B-VGA-1
[647.626305] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.390s)
[647.630573] Subtest suspend-read-crc: SUCCESS (4.697s)
[651.894491] Closing watchdogs
Done.