[66.028466] Initializing watchdogs
[66.028999]   /dev/watchdog0
[66.053134] [001/165] (960s left) i915_module_load (load)
[66.622258] Starting subtest: load
[72.343285] Subtest load: SUCCESS (5.723s)
[72.551555] [002/165] (954s left) core_auth (basic-auth)
[74.034286] Starting subtest: basic-auth
[74.039519] Subtest basic-auth: SUCCESS (0.004s)
[74.188181] [003/165] (952s left) debugfs_test (read_all_entries)
[74.663873] Starting subtest: read_all_entries
[74.904288] Subtest read_all_entries: SUCCESS (0.239s)
[75.186176] [004/165] (951s left) debugfs_test (basic-hwmon)
[75.679580] Starting subtest: basic-hwmon
[75.695157] Subtest basic-hwmon: SKIP (0.001s)
[75.924538] [005/165] (951s left) fbdev (eof)
[76.409366] Starting subtest: eof
[76.413673] Subtest eof: SUCCESS (0.004s)
[76.560192] [006/165] (950s left) fbdev (info)
[77.079556] Starting subtest: info
[77.091510] Subtest info: SUCCESS (0.000s)
[77.224275] [007/165] (950s left) fbdev (nullptr)
[77.635724] Starting subtest: nullptr
[77.640230] Subtest nullptr: SUCCESS (0.000s)
[77.748834] [008/165] (949s left) fbdev (read)
[78.253620] Starting subtest: read
[78.582639] Subtest read: SUCCESS (0.327s)
[78.699376] [009/165] (948s left) fbdev (write)
[79.220291] Starting subtest: write
[79.433609] Subtest write: SUCCESS (0.210s)
[79.559375] [010/165] (947s left) gem_basic (bad-close)
[80.041295] Starting subtest: bad-close
[80.046753] Subtest bad-close: SUCCESS (0.000s)
[80.179707] [011/165] (947s left) gem_basic (create-close)
[80.687267] Starting subtest: create-close
[80.698223] Subtest create-close: SUCCESS (0.001s)
[80.853154] [012/165] (946s left) gem_basic (create-fd-close)
[81.364576] Starting subtest: create-fd-close
[81.370570] Subtest create-fd-close: SUCCESS (0.001s)
[81.514724] [013/165] (946s left) gem_busy (busy@all-engines)
[82.094139] Starting subtest: busy
[82.098251] Starting dynamic subtest: all-engines
[82.211440] Dynamic subtest all-engines: SUCCESS (0.122s)
[82.214445] Subtest busy: SUCCESS (0.125s)
[82.704202] [014/165] (945s left) gem_close_race (basic-process)
[83.223128] Starting subtest: basic-process
[83.437514] Subtest basic-process: SUCCESS (0.216s)
[83.704822] [015/165] (944s left) gem_close_race (basic-threads)
[84.190681] Starting subtest: basic-threads
[85.603696] Subtest basic-threads: SUCCESS (1.416s)
[85.871631] [016/165] (942s left) gem_ctx_create (basic)
[86.379459] Subtest basic: SKIP (0.000s)
[86.470374] [017/165] (941s left) gem_ctx_create (basic-files)
[86.916641] Subtest basic-files: SKIP (0.000s)
[87.025979] [018/165] (941s left) gem_ctx_exec (basic)
[87.458695] Subtest basic: SKIP (0.000s)
[87.572944] [019/165] (940s left) gem_exec_basic (basic)
[88.083619] Starting subtest: basic
[88.087828] Starting dynamic subtest: rcs0-smem
[88.091114] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[88.093838] Subtest basic: SUCCESS (0.006s)
[88.374858] [020/165] (940s left) gem_exec_create (basic)
[88.929083] Starting subtest: basic
[88.934637] Starting dynamic subtest: smem
[91.098227] Dynamic subtest smem: SUCCESS (2.173s)
[91.101284] Subtest basic: SUCCESS (2.176s)
[91.398505] [021/165] (937s left) gem_exec_fence (basic-busy)
[92.098605] Starting subtest: basic-busy
[92.103325] Starting dynamic subtest: rcs0
[92.137116] Dynamic subtest rcs0: SUCCESS (0.042s)
[92.140547] Subtest basic-busy: SUCCESS (0.045s)
[93.075913] [022/165] (935s left) gem_exec_fence (basic-wait)
[93.775534] Starting subtest: basic-wait
[93.778757] Starting dynamic subtest: rcs0
[93.805361] Dynamic subtest rcs0: SUCCESS (0.032s)
[93.808402] Subtest basic-wait: SUCCESS (0.034s)
[94.495563] [023/165] (934s left) gem_exec_fence (basic-await)
[95.220976] Starting subtest: basic-await
[95.225408] Starting dynamic subtest: rcs0
[95.342639] Dynamic subtest rcs0: SUCCESS (0.120s)
[95.345529] Subtest basic-await: SUCCESS (0.123s)
[96.046283] [024/165] (932s left) gem_exec_fence (nb-await)
[96.732980] Starting subtest: nb-await
[96.736742] Starting dynamic subtest: rcs0
[96.794476] Dynamic subtest rcs0: SUCCESS (0.061s)
[96.798578] Subtest nb-await: SUCCESS (0.063s)
[97.513386] [025/165] (931s left) gem_exec_gttfill (basic)
[98.012579] Starting subtest: basic
[113.342418] Subtest basic: SUCCESS (15.332s)
[113.657791] [026/165] (915s left) gem_exec_parallel (engines)
[114.577298] Starting subtest: engines
[114.581633] Starting dynamic subtest: basic
[118.246674] Dynamic subtest basic: SUCCESS (3.669s)
[118.297757] Starting dynamic subtest: contexts
[118.308804] Dynamic subtest contexts: SKIP (0.004s)
[118.349509] Starting dynamic subtest: fds
[118.354955] Dynamic subtest fds: SKIP (0.003s)
[118.388615] Starting dynamic subtest: userptr
[121.937525] Dynamic subtest userptr: SUCCESS (3.676s)
[121.941586] Subtest engines: SUCCESS (7.364s)
[122.239649] [027/165] (906s left) gem_exec_store (basic)
[122.721441] Starting subtest: basic
[122.767943] Subtest basic: SUCCESS (0.051s)
[123.047962] [028/165] (906s left) gem_flink_basic (bad-flink)
[123.460152] Starting subtest: bad-flink
[123.463825] Subtest bad-flink: SUCCESS (0.000s)
[123.637124] [029/165] (905s left) gem_flink_basic (bad-open)
[124.086683] Starting subtest: bad-open
[124.090674] Subtest bad-open: SUCCESS (0.000s)
[124.225586] [030/165] (905s left) gem_flink_basic (basic)
[124.641744] Starting subtest: basic
[124.646953] Subtest basic: SUCCESS (0.001s)
[124.777778] [031/165] (904s left) gem_flink_basic (double-flink)
[125.197466] Starting subtest: double-flink
[125.200845] Subtest double-flink: SUCCESS (0.000s)
[125.332222] [032/165] (904s left) gem_flink_basic (flink-lifetime)
[125.761763] Starting subtest: flink-lifetime
[125.767470] Subtest flink-lifetime: SUCCESS (0.007s)
[125.916191] [033/165] (903s left) gem_huc_copy (huc-copy)
[126.382202] Subtest huc-copy: SKIP (0.000s)
[126.500685] [034/165] (903s left) gem_linear_blits (basic)
[127.436592] Starting subtest: basic
[127.505205] Subtest basic: SUCCESS (0.062s)
[127.730582] [035/165] (902s left) gem_mmap (basic)
[128.550502] Starting subtest: basic
[128.567656] Subtest basic: SUCCESS (0.003s)
[128.745173] [036/165] (901s left) gem_mmap_gtt (basic)
[129.188952] Starting subtest: basic
[129.195116] Subtest basic: SUCCESS (0.003s)
[129.339468] [037/165] (900s left) gem_render_linear_blits (basic)
[129.812344] Starting subtest: basic
[129.953361] Subtest basic: SUCCESS (0.139s)
[130.076407] [038/165] (900s left) gem_render_tiled_blits (basic)
[130.501606] Starting subtest: basic
[130.663307] Subtest basic: SUCCESS (0.158s)
[130.787189] [039/165] (899s left) gem_ringfill (basic-all)
[131.291414] Starting subtest: basic-all
[132.502728] Subtest basic-all: SUCCESS (1.205s)
[132.663978] [040/165] (897s left) gem_softpin (allocator-basic)
[133.119209] Subtest allocator-basic: SKIP (0.000s)
[133.253148] [041/165] (897s left) gem_softpin (allocator-basic-reserve)
[133.703478] Subtest allocator-basic-reserve: SKIP (0.000s)
[133.836358] [042/165] (896s left) gem_softpin (safe-alignment)
[134.264808] Starting subtest: safe-alignment
[134.298644] Subtest safe-alignment: SUCCESS (0.041s)
[134.473094] [043/165] (896s left) gem_sync (basic-all)
[134.992733] Starting subtest: basic-all
[137.466711] Subtest basic-all: SUCCESS (2.473s)
[137.744850] [044/165] (892s left) gem_sync (basic-each)
[138.220104] Starting subtest: basic-each
[140.631064] Subtest basic-each: SUCCESS (2.410s)
[140.921937] [045/165] (889s left) gem_tiled_blits (basic)
[141.675911] Starting subtest: basic
[141.778977] Subtest basic: SUCCESS (0.105s)
[142.025089] [046/165] (888s left) gem_tiled_fence_blits (basic)
[143.178132] Starting subtest: basic
[143.244805] Subtest basic: SUCCESS (0.075s)
[143.493317] [047/165] (887s left) gem_tiled_pread_basic
[146.058435] [048/165] (885s left) gem_wait (busy@all-engines)
[146.605931] Starting subtest: busy
[146.610829] Starting dynamic subtest: all-engines
[147.139421] Dynamic subtest all-engines: SUCCESS (0.535s)
[147.143343] Subtest busy: SUCCESS (0.538s)
[147.547111] [049/165] (883s left) gem_wait (wait@all-engines)
[148.082921] Starting subtest: wait
[148.086704] Starting dynamic subtest: all-engines
[149.132590] Dynamic subtest all-engines: SUCCESS (1.050s)
[149.135698] Subtest wait: SUCCESS (1.052s)
[149.566075] [050/165] (881s left) i915_getparams_basic (basic-eu-total)
[149.991830] Starting subtest: basic-eu-total
[149.998702] Subtest basic-eu-total: SUCCESS (0.000s)
[150.129453] [051/165] (881s left) i915_getparams_basic (basic-subslice-total)
[150.535511] Starting subtest: basic-subslice-total
[150.542282] Subtest basic-subslice-total: SUCCESS (0.000s)
[150.681828] [052/165] (880s left) i915_hangman (error-state-basic)
[151.137904] Starting subtest: error-state-basic
[151.560267] Subtest error-state-basic: SUCCESS (0.426s)
[151.690650] [053/165] (879s left) i915_pciid
[152.323411] [054/165] (879s left) kms_addfb_basic (addfb25-4-tiled)
[152.842837] Starting subtest: addfb25-4-tiled
[152.847891] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[153.025903] [055/165] (878s left) kms_addfb_basic (addfb25-bad-modifier)
[153.473723] Starting subtest: addfb25-bad-modifier
[153.478514] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[153.684682] [056/165] (878s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[154.136589] Starting subtest: addfb25-framebuffer-vs-set-tiling
[154.140525] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[154.365907] [057/165] (877s left) kms_addfb_basic (addfb25-modifier-no-flag)
[154.815260] Starting subtest: addfb25-modifier-no-flag
[154.820679] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[155.106951] [058/165] (877s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[155.540532] Starting subtest: addfb25-x-tiled-legacy
[155.544831] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[155.779561] [059/165] (876s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[156.238458] Starting subtest: addfb25-x-tiled-mismatch-legacy
[156.241472] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[156.442861] [060/165] (875s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[156.951514] Starting subtest: addfb25-yf-tiled-legacy
[156.955749] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[157.113212] [061/165] (875s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[157.603146] Starting subtest: addfb25-y-tiled-legacy
[157.607423] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[157.750812] [062/165] (874s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[158.287966] Starting subtest: addfb25-y-tiled-small-legacy
[158.295615] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[158.436956] [063/165] (874s left) kms_addfb_basic (bad-pitch-0)
[158.855694] Starting subtest: bad-pitch-0
[158.859662] Subtest bad-pitch-0: SUCCESS (0.000s)
[159.052375] [064/165] (873s left) kms_addfb_basic (bad-pitch-1024)
[159.520612] Starting subtest: bad-pitch-1024
[159.528749] Subtest bad-pitch-1024: SUCCESS (0.000s)
[159.729112] [065/165] (873s left) kms_addfb_basic (bad-pitch-128)
[160.194701] Starting subtest: bad-pitch-128
[160.202718] Subtest bad-pitch-128: SUCCESS (0.000s)
[160.389944] [066/165] (872s left) kms_addfb_basic (bad-pitch-256)
[160.841705] Starting subtest: bad-pitch-256
[160.845780] Subtest bad-pitch-256: SUCCESS (0.000s)
[161.103296] [067/165] (871s left) kms_addfb_basic (bad-pitch-32)
[161.584581] Starting subtest: bad-pitch-32
[161.588734] Subtest bad-pitch-32: SUCCESS (0.000s)
[161.788886] [068/165] (871s left) kms_addfb_basic (bad-pitch-63)
[162.238673] Starting subtest: bad-pitch-63
[162.242509] Subtest bad-pitch-63: SUCCESS (0.000s)
[162.460933] [069/165] (870s left) kms_addfb_basic (bad-pitch-65536)
[162.901835] Starting subtest: bad-pitch-65536
[162.907544] Subtest bad-pitch-65536: SUCCESS (0.002s)
[163.109759] [070/165] (870s left) kms_addfb_basic (bad-pitch-999)
[163.563444] Starting subtest: bad-pitch-999
[163.567443] Subtest bad-pitch-999: SUCCESS (0.000s)
[163.773223] [071/165] (869s left) kms_addfb_basic (basic)
[164.209518] Starting subtest: basic
[164.213643] Subtest basic: SUCCESS (0.000s)
[164.412516] [072/165] (869s left) kms_addfb_basic (basic-x-tiled-legacy)
[164.858688] Starting subtest: basic-x-tiled-legacy
[164.863156] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[165.067476] [073/165] (868s left) kms_addfb_basic (basic-y-tiled-legacy)
[165.524779] Starting subtest: basic-y-tiled-legacy
[165.531605] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[165.766207] [074/165] (867s left) kms_addfb_basic (bo-too-small)
[166.243404] Starting subtest: bo-too-small
[166.246952] Subtest bo-too-small: SUCCESS (0.002s)
[166.392257] [075/165] (867s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[166.874773] Starting subtest: bo-too-small-due-to-tiling
[166.879464] Subtest bo-too-small-due-to-tiling: SUCCESS (0.003s)
[167.070172] [076/165] (866s left) kms_addfb_basic (clobberred-modifier)
[167.509464] Starting subtest: clobberred-modifier
[167.512659] Subtest clobberred-modifier: SUCCESS (0.001s)
[167.741655] [077/165] (866s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[168.174513] Starting subtest: framebuffer-vs-set-tiling
[168.177864] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[168.429200] [078/165] (865s left) kms_addfb_basic (invalid-get-prop)
[168.852963] Starting subtest: invalid-get-prop
[168.857744] Subtest invalid-get-prop: SUCCESS (0.000s)
[169.071486] [079/165] (865s left) kms_addfb_basic (invalid-get-prop-any)
[169.500842] Starting subtest: invalid-get-prop-any
[169.504110] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[169.731137] [080/165] (864s left) kms_addfb_basic (invalid-set-prop)
[170.158496] Starting subtest: invalid-set-prop
[170.162565] Subtest invalid-set-prop: SUCCESS (0.000s)
[170.410841] [081/165] (864s left) kms_addfb_basic (invalid-set-prop-any)
[170.872957] Starting subtest: invalid-set-prop-any
[170.878232] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[171.127142] [082/165] (863s left) kms_addfb_basic (no-handle)
[171.553993] Starting subtest: no-handle
[171.560671] Subtest no-handle: SUCCESS (0.000s)
[171.764152] [083/165] (862s left) kms_addfb_basic (size-max)
[172.246708] Starting subtest: size-max
[172.249930] Subtest size-max: SUCCESS (0.002s)
[172.400279] [084/165] (862s left) kms_addfb_basic (small-bo)
[172.908964] Starting subtest: small-bo
[172.914401] Subtest small-bo: SUCCESS (0.000s)
[173.072940] [085/165] (861s left) kms_addfb_basic (tile-pitch-mismatch)
[173.518569] Starting subtest: tile-pitch-mismatch
[173.525686] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[173.757994] [086/165] (861s left) kms_addfb_basic (too-high)
[174.290207] Starting subtest: too-high
[174.295236] Subtest too-high: SUCCESS (0.005s)
[174.454151] [087/165] (860s left) kms_addfb_basic (too-wide)
[174.942923] Starting subtest: too-wide
[174.946694] Subtest too-wide: SUCCESS (0.000s)
[175.097774] [088/165] (860s left) kms_addfb_basic (unused-handle)
[175.565512] Starting subtest: unused-handle
[175.569560] Subtest unused-handle: SUCCESS (0.000s)
[175.760966] [089/165] (859s left) kms_addfb_basic (unused-modifier)
[176.199778] Starting subtest: unused-modifier
[176.205213] Subtest unused-modifier: SUCCESS (0.001s)
[176.402408] [090/165] (859s left) kms_addfb_basic (unused-offsets)
[176.870674] Starting subtest: unused-offsets
[176.874999] Subtest unused-offsets: SUCCESS (0.000s)
[177.089780] [091/165] (858s left) kms_addfb_basic (unused-pitches)
[177.519849] Starting subtest: unused-pitches
[177.524217] Subtest unused-pitches: SUCCESS (0.000s)
[177.780343] [092/165] (857s left) kms_busy (basic)
[178.280576] Starting subtest: basic
[178.285467] Starting dynamic subtest: flip
[179.764772] Dynamic subtest flip: SUCCESS (1.480s)
[179.819851] Starting dynamic subtest: modeset
[179.828188] Dynamic subtest modeset: SKIP (0.000s)
[179.835468] Subtest basic: SUCCESS (1.488s)
[180.071971] [093/165] (855s left) kms_prop_blob (basic)
[180.563719] Starting subtest: basic
[180.568992] Subtest basic: SUCCESS (0.000s)
[180.713162] [094/165] (855s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[181.220971] Starting subtest: basic-busy-flip-before-cursor-atomic
[181.239693] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.015s)
[181.378365] [095/165] (854s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[181.888256] Starting subtest: basic-busy-flip-before-cursor-legacy
[183.210325] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.320s)
[183.488829] [096/165] (852s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[184.039621] Starting subtest: basic-flip-after-cursor-atomic
[184.047687] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[184.207751] [097/165] (851s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[184.716743] Starting subtest: basic-flip-after-cursor-legacy
[185.999291] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.286s)
[186.311343] [098/165] (849s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[186.814684] Starting subtest: basic-flip-after-cursor-varying-size
[188.139526] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.320s)
[188.426865] [099/165] (847s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[188.944645] Starting subtest: basic-flip-before-cursor-atomic
[188.951246] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[189.109281] [100/165] (847s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[189.593225] Starting subtest: basic-flip-before-cursor-legacy
[190.919570] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.313s)
[191.189450] [101/165] (845s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[191.677711] Starting subtest: basic-flip-before-cursor-varying-size
[192.945317] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.268s)
[193.255752] [102/165] (843s left) kms_dsc (dsc-basic)
[193.778288] Subtest dsc-basic: SKIP (0.000s)
[193.884486] [103/165] (842s left) kms_flip (basic-flip-vs-dpms)
[194.353425] Starting subtest: basic-flip-vs-dpms
[194.357536] Starting dynamic subtest: A-VGA1
[196.003181] Dynamic subtest A-VGA1: SUCCESS (1.655s)
[196.049273] Starting dynamic subtest: B-VGA1
[197.586143] Dynamic subtest B-VGA1: SUCCESS (1.577s)
[197.589858] Subtest basic-flip-vs-dpms: SUCCESS (3.239s)
[198.038987] [104/165] (838s left) kms_flip (basic-flip-vs-modeset)
[198.548632] Starting subtest: basic-flip-vs-modeset
[198.552759] Starting dynamic subtest: A-VGA1
[200.315582] Dynamic subtest A-VGA1: SUCCESS (1.758s)
[200.364383] Starting dynamic subtest: B-VGA1
[201.713219] Dynamic subtest B-VGA1: SUCCESS (1.390s)
[201.723759] Subtest basic-flip-vs-modeset: SUCCESS (3.158s)
[202.081427] [105/165] (834s left) kms_flip (basic-flip-vs-wf_vblank)
[202.561427] Starting subtest: basic-flip-vs-wf_vblank
[202.564968] Starting dynamic subtest: A-VGA1
[204.527789] Dynamic subtest A-VGA1: SUCCESS (1.962s)
[204.577348] Starting dynamic subtest: B-VGA1
[206.239290] Dynamic subtest B-VGA1: SUCCESS (1.703s)
[206.246159] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.671s)
[206.725357] [106/165] (830s left) kms_flip (basic-plain-flip)
[207.236710] Starting subtest: basic-plain-flip
[207.241539] Starting dynamic subtest: A-VGA1
[208.884630] Dynamic subtest A-VGA1: SUCCESS (1.643s)
[208.937414] Starting dynamic subtest: B-VGA1
[210.317680] Dynamic subtest B-VGA1: SUCCESS (1.431s)
[210.323570] Subtest basic-plain-flip: SUCCESS (3.081s)
[210.798432] [107/165] (826s left) kms_force_connector_basic (force-connector-state)
[211.341214] Starting subtest: force-connector-state
[211.618862] Subtest force-connector-state: SUCCESS (0.264s)
[212.071656] [108/165] (825s left) kms_force_connector_basic (force-edid)
[212.641794] Starting subtest: force-edid
[212.748359] Subtest force-edid: SUCCESS (0.110s)
[213.019885] [109/165] (824s left) kms_force_connector_basic (force-load-detect)
[213.522796] Starting subtest: force-load-detect
[213.951273] Subtest force-load-detect: SUCCESS (0.414s)
[214.395583] [110/165] (823s left) kms_force_connector_basic (prune-stale-modes)
[214.919447] Starting subtest: prune-stale-modes
[215.005747] Subtest prune-stale-modes: SUCCESS (0.080s)
[215.260852] [111/165] (822s left) kms_frontbuffer_tracking (basic)
[215.798342] Subtest basic: SKIP (0.000s)
[215.952339] [112/165] (821s left) kms_hdmi_inject (inject-audio)
[216.397195] Subtest inject-audio: SKIP (0.000s)
[216.517165] [113/165] (821s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[217.018777] Starting subtest: compare-crc-sanitycheck-xr24
[217.023622] Starting dynamic subtest: pipe-A-VGA-1
[217.408865] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.384s)
[217.459368] Starting dynamic subtest: pipe-B-VGA-1
[217.911948] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.496s)
[217.915425] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.890s)
[218.207195] [114/165] (819s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[218.728495] Starting subtest: compare-crc-sanitycheck-nv12
[218.740142] Starting dynamic subtest: pipe-A-VGA-1
[218.748320] Dynamic subtest pipe-A-VGA-1: SKIP (0.002s)
[218.797919] Starting dynamic subtest: pipe-B-VGA-1
[218.809443] Dynamic subtest pipe-B-VGA-1: SKIP (0.003s)
[218.817168] Subtest compare-crc-sanitycheck-nv12: SKIP (0.016s)
[218.972606] [115/165] (819s left) kms_pipe_crc_basic (hang-read-crc)
[219.528298] Starting subtest: hang-read-crc
[219.534498] Starting dynamic subtest: pipe-A-VGA-1
[220.815253] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.284s)
[220.866250] Starting dynamic subtest: pipe-B-VGA-1
[222.155530] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.333s)
[222.160377] Subtest hang-read-crc: SUCCESS (2.630s)
[222.423181] [116/165] (815s left) kms_pipe_crc_basic (nonblocking-crc)
[222.928146] Starting subtest: nonblocking-crc
[222.931390] Starting dynamic subtest: pipe-A-VGA-1
[223.523201] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.592s)
[223.571173] Starting dynamic subtest: pipe-B-VGA-1
[224.235268] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.706s)
[224.239505] Subtest nonblocking-crc: SUCCESS (1.309s)
[224.510214] [117/165] (813s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[225.026273] Starting subtest: nonblocking-crc-frame-sequence
[225.032597] Starting dynamic subtest: pipe-A-VGA-1
[225.606939] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.581s)
[225.672676] Starting dynamic subtest: pipe-B-VGA-1
[226.332357] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.719s)
[226.338473] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.318s)
[226.633981] [118/165] (811s left) kms_pipe_crc_basic (read-crc)
[227.152881] Starting subtest: read-crc
[227.157390] Starting dynamic subtest: pipe-A-VGA-1
[227.650746] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.495s)
[227.708381] Starting dynamic subtest: pipe-B-VGA-1
[228.294389] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.634s)
[228.299759] Subtest read-crc: SUCCESS (1.141s)
[228.585391] [119/165] (809s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[229.099475] Starting subtest: read-crc-frame-sequence
[229.103691] Starting dynamic subtest: pipe-A-VGA-1
[229.597426] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.494s)
[229.657564] Starting dynamic subtest: pipe-B-VGA-1
[230.211964] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.605s)
[230.216899] Subtest read-crc-frame-sequence: SUCCESS (1.112s)
[230.486795] [120/165] (808s left) kms_pm_backlight (basic-brightness)
[230.981543] Subtest basic-brightness: SKIP (0.000s)
[231.116752] [121/165] (807s left) kms_psr (primary_page_flip)
[231.550513] Subtest primary_page_flip: SKIP (0.000s)
[231.663142] [122/165] (807s left) kms_psr (cursor_plane_move)
[232.093718] Subtest cursor_plane_move: SKIP (0.000s)
[232.209577] [123/165] (806s left) kms_psr (sprite_plane_onoff)
[232.710640] Subtest sprite_plane_onoff: SKIP (0.000s)
[232.811906] [124/165] (806s left) kms_psr (primary_mmap_gtt)
[233.252879] Subtest primary_mmap_gtt: SKIP (0.000s)
[233.361506] [125/165] (805s left) kms_setmode (basic-clone-single-crtc)
[233.814975] Starting subtest: basic-clone-single-crtc
[233.827379] Subtest basic-clone-single-crtc: SKIP (0.001s)
[233.958731] [126/165] (805s left) i915_pm_rpm (basic-pci-d3-state)
[245.963957] Subtest basic-pci-d3-state: SKIP (0.000s)
[246.067514] [127/165] (793s left) i915_pm_rpm (basic-rte)
[246.474865] Starting subtest: basic-rte
[257.991767] Subtest basic-rte: SKIP (11.494s)
[258.092531] [128/165] (781s left) i915_pm_rps (basic-api)
[258.521632] Subtest basic-api: SKIP (0.000s)
[258.625638] [129/165] (780s left) prime_self_import (basic-llseek-bad)
[259.017249] Starting subtest: basic-llseek-bad
[259.026535] Subtest basic-llseek-bad: SUCCESS (0.010s)
[259.169332] [130/165] (780s left) prime_self_import (basic-llseek-size)
[259.557731] Starting subtest: basic-llseek-size
[259.574858] Subtest basic-llseek-size: SUCCESS (0.018s)
[259.721512] [131/165] (780s left) prime_self_import (basic-with_fd_dup)
[260.116372] Starting subtest: basic-with_fd_dup
[260.133661] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[260.283157] [132/165] (779s left) prime_self_import (basic-with_one_bo)
[260.670901] Starting subtest: basic-with_one_bo
[260.686941] Subtest basic-with_one_bo: SUCCESS (0.017s)
[260.825846] [133/165] (779s left) prime_self_import (basic-with_one_bo_two_files)
[261.216588] Starting subtest: basic-with_one_bo_two_files
[261.232860] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[261.383864] [134/165] (778s left) prime_self_import (basic-with_two_bos)
[261.772516] Starting subtest: basic-with_two_bos
[261.788267] Subtest basic-with_two_bos: SUCCESS (0.018s)
[261.937418] [135/165] (778s left) prime_vgem (basic-fence-flip)
[262.353134] Starting subtest: basic-fence-flip
[262.955426] Subtest basic-fence-flip: SUCCESS (0.599s)
[263.121621] [136/165] (777s left) prime_vgem (basic-fence-mmap)
[263.551846] Starting subtest: basic-fence-mmap
[263.726628] Subtest basic-fence-mmap: SUCCESS (0.173s)
[263.874288] [137/165] (776s left) prime_vgem (basic-fence-read)
[264.304661] Starting subtest: basic-fence-read
[264.613963] Subtest basic-fence-read: SUCCESS (0.308s)
[264.755552] [138/165] (775s left) prime_vgem (basic-gtt)
[265.191617] Starting subtest: basic-gtt
[265.275637] Subtest basic-gtt: SUCCESS (0.084s)
[265.438741] [139/165] (775s left) prime_vgem (basic-read)
[265.870881] Starting subtest: basic-read
[266.004499] Subtest basic-read: SUCCESS (0.132s)
[266.156859] [140/165] (774s left) prime_vgem (basic-write)
[266.590588] Starting subtest: basic-write
[266.732656] Subtest basic-write: SUCCESS (0.141s)
[266.871430] [141/165] (773s left) vgem_basic (setversion)
[267.288884] Starting subtest: setversion
[267.296418] Subtest setversion: SUCCESS (0.000s)
[267.410420] [142/165] (773s left) vgem_basic (create)
[267.823226] Starting subtest: create
[267.827461] Subtest create: SUCCESS (0.003s)
[267.938873] [143/165] (772s left) vgem_basic (debugfs)
[268.340538] Starting subtest: debugfs
[268.344527] Subtest debugfs: SUCCESS (0.003s)
[268.458527] [144/165] (772s left) vgem_basic (dmabuf-export)
[268.873833] Starting subtest: dmabuf-export
[268.882854] Subtest dmabuf-export: SUCCESS (0.010s)
[269.024631] [145/165] (771s left) vgem_basic (dmabuf-fence)
[269.440328] Starting subtest: dmabuf-fence
[269.444608] Subtest dmabuf-fence: SUCCESS (0.004s)
[269.555523] [146/165] (771s left) vgem_basic (dmabuf-fence-before)
[269.958593] Starting subtest: dmabuf-fence-before
[269.962642] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[270.091720] [147/165] (771s left) vgem_basic (dmabuf-mmap)
[270.507617] Starting subtest: dmabuf-mmap
[270.586662] Subtest dmabuf-mmap: SUCCESS (0.081s)
[270.710941] [148/165] (770s left) vgem_basic (mmap)
[271.107675] Starting subtest: mmap
[271.166316] Subtest mmap: SUCCESS (0.060s)
[271.295520] [149/165] (770s left) vgem_basic (second-client)
[271.707958] Starting subtest: second-client
[271.744119] Subtest second-client: SUCCESS (0.033s)
[271.857474] [150/165] (769s left) vgem_basic (sysfs)
[272.274711] Starting subtest: sysfs
[272.280392] Subtest sysfs: SUCCESS (0.005s)
[272.410393] [151/165] (769s left) core_hotunplug (unbind-rebind)
[272.956571] Starting subtest: unbind-rebind
[277.359518] Subtest unbind-rebind: SUCCESS (4.400s)
[277.494619] [152/165] (764s left) vgem_basic (unload)
[277.926543] Starting subtest: unload
[307.254728] Subtest unload: SUCCESS (29.327s)
[307.514774] [153/165] (734s left) i915_module_load (reload)
[307.906410] Starting subtest: reload
[312.826453] Subtest reload: SUCCESS (4.908s)
[313.139465] [154/165] (728s left) gem_lmem_swapping (basic)
[314.301317] Subtest basic: SKIP (0.000s)
[314.413610] [155/165] (727s left) gem_lmem_swapping (parallel-random-engines)
[314.832307] Subtest parallel-random-engines: SKIP (0.000s)
[314.933873] [156/165] (727s left) gem_lmem_swapping (random-engines)
[315.350633] Subtest random-engines: SKIP (0.000s)
[315.447228] [157/165] (726s left) gem_lmem_swapping (verify-random)
[315.870638] Subtest verify-random: SKIP (0.000s)
[315.963716] [158/165] (726s left) i915_pm_rpm (module-reload)
[327.881574] Subtest module-reload: SKIP (0.000s)
[327.974500] [159/165] (714s left) i915_selftest (live)
[330.140621] Starting subtest: live
[330.144622] Starting dynamic subtest: sanitycheck
[332.552862] Dynamic subtest sanitycheck: SUCCESS (2.411s)
[332.584687] Starting dynamic subtest: uncore
[334.595524] Dynamic subtest uncore: SUCCESS (2.039s)
[334.634174] Starting dynamic subtest: workarounds
[336.645638] Dynamic subtest workarounds: SUCCESS (2.047s)
[336.678992] Starting dynamic subtest: gt_engines
[338.694707] Dynamic subtest gt_engines: SUCCESS (2.046s)
[338.727962] Starting dynamic subtest: gt_timelines
[349.794198] Dynamic subtest gt_timelines: SUCCESS (11.098s)
[349.831137] Starting dynamic subtest: gt_contexts
[351.910499] Dynamic subtest gt_contexts: SUCCESS (2.114s)
[351.943340] Starting dynamic subtest: gt_lrc
[353.968391] Dynamic subtest gt_lrc: SUCCESS (2.053s)
[354.006859] Starting dynamic subtest: gt_mocs
[356.052834] Dynamic subtest gt_mocs: SUCCESS (2.080s)
[356.090484] Starting dynamic subtest: gt_pm
[358.554817] Dynamic subtest gt_pm: SUCCESS (2.501s)
[358.586301] Starting dynamic subtest: gt_heartbeat
[360.710329] Dynamic subtest gt_heartbeat: SUCCESS (2.152s)
[360.742928] Starting dynamic subtest: gt_tlb
[362.782716] Dynamic subtest gt_tlb: SUCCESS (2.067s)
[362.820692] Starting dynamic subtest: requests
[367.421115] Dynamic subtest requests: SUCCESS (4.636s)
[367.453442] Starting dynamic subtest: migrate
[369.456584] Dynamic subtest migrate: SUCCESS (2.032s)
[369.488450] Starting dynamic subtest: active
[371.560521] Dynamic subtest active: SUCCESS (2.099s)
[371.591778] Starting dynamic subtest: objects
[374.649488] Dynamic subtest objects: SUCCESS (3.087s)
[374.681258] Starting dynamic subtest: mman
[386.546484] Dynamic subtest mman: SUCCESS (11.894s)
[386.579266] Starting dynamic subtest: dmabuf
[388.710685] Dynamic subtest dmabuf: SUCCESS (2.158s)
[388.748555] Starting dynamic subtest: vma
[390.835294] Dynamic subtest vma: SUCCESS (2.123s)
[390.867413] Starting dynamic subtest: coherency
[397.856434] Dynamic subtest coherency: SUCCESS (7.017s)
[397.888631] Starting dynamic subtest: gtt
[402.920545] Dynamic subtest gtt: SUCCESS (5.061s)
[402.952288] Starting dynamic subtest: gem
[405.048613] Dynamic subtest gem: SUCCESS (2.125s)
[405.080559] Starting dynamic subtest: evict
[407.112450] Dynamic subtest evict: SUCCESS (2.060s)
[407.150550] Starting dynamic subtest: hugepages
[409.214171] Dynamic subtest hugepages: SUCCESS (2.098s)
[409.251466] Starting dynamic subtest: gem_contexts
[411.274380] Dynamic subtest gem_contexts: SUCCESS (2.056s)
[411.307369] Starting dynamic subtest: client
[413.369188] Dynamic subtest client: SUCCESS (2.091s)
[413.401294] Starting dynamic subtest: gem_migrate
[415.453527] Dynamic subtest gem_migrate: SUCCESS (2.081s)
[415.486573] Starting dynamic subtest: reset
[418.088318] Dynamic subtest reset: SUCCESS (2.631s)
[418.126819] Starting dynamic subtest: memory_region
[420.154550] Dynamic subtest memory_region: SUCCESS (2.063s)
[420.187778] Starting dynamic subtest: hangcheck
[423.313137] Dynamic subtest hangcheck: SUCCESS (3.154s)
[423.351069] Starting dynamic subtest: execlists
[425.380411] Dynamic subtest execlists: SUCCESS (2.063s)
[425.414456] Starting dynamic subtest: ring_submission
[427.449875] Dynamic subtest ring_submission: SUCCESS (2.066s)
[427.488743] Starting dynamic subtest: perf
[429.514740] Dynamic subtest perf: SUCCESS (2.062s)
[429.547331] Starting dynamic subtest: slpc
[431.563216] Dynamic subtest slpc: SUCCESS (2.044s)
[431.608557] Starting dynamic subtest: guc
[433.623446] Dynamic subtest guc: SUCCESS (2.056s)
[433.655969] Starting dynamic subtest: guc_multi_lrc
[435.675584] Dynamic subtest guc_multi_lrc: SUCCESS (2.048s)
[435.707951] Starting dynamic subtest: guc_hang
[437.726664] Dynamic subtest guc_hang: SUCCESS (2.047s)
[437.758945] Starting dynamic subtest: late_gt_pm
[439.792145] Dynamic subtest late_gt_pm: SUCCESS (2.061s)
[439.796587] Subtest live: SUCCESS (109.655s)
[439.891944] [160/165] (602s left) dmabuf (all-tests)
[440.300731] Starting subtest: all-tests
[440.304635] Starting dynamic subtest: sanitycheck
[440.389811] Dynamic subtest sanitycheck: SUCCESS (0.089s)
[440.431945] Starting dynamic subtest: dma_fence
[440.602728] Dynamic subtest dma_fence: SUCCESS (0.208s)
[440.637920] Starting dynamic subtest: dma_fence_chain
[492.445641] Dynamic subtest dma_fence_chain: SUCCESS (51.837s)
[492.490504] Starting dynamic subtest: dma_fence_unwrap
[492.544531] Dynamic subtest dma_fence_unwrap: SUCCESS (0.096s)
[492.587765] Starting dynamic subtest: dma_resv
[492.642144] Dynamic subtest dma_resv: SUCCESS (0.093s)
[492.646133] Subtest all-tests: SUCCESS (52.344s)
[492.736135] [161/165] (550s left) i915_suspend (basic-s2idle-without-i915)
[493.130695] Starting subtest: basic-s2idle-without-i915
[514.878160] Subtest basic-s2idle-without-i915: SUCCESS (6.447s)
[517.173944] [162/165] (543s left) i915_suspend (basic-s3-without-i915)
[517.657638] Starting subtest: basic-s3-without-i915
[537.987191] Subtest basic-s3-without-i915: SUCCESS (4.483s)
[542.698847] [163/165] (537s left) gem_exec_suspend (basic-s0)
[543.307833] Starting subtest: basic-S0
[543.314827] Starting dynamic subtest: smem
[563.914019] Dynamic subtest smem: SUCCESS (5.977s)
[563.917924] Subtest basic-S0: SUCCESS (5.986s)
[567.222990] [164/165] (531s left) gem_exec_suspend (basic-s3)
[567.680447] Starting subtest: basic-S3
[567.684197] Starting dynamic subtest: smem
[590.181583] Dynamic subtest smem: SUCCESS (6.131s)
[590.184664] Subtest basic-S3: SUCCESS (6.136s)
[593.470916] [165/165] (524s left) kms_pipe_crc_basic (suspend-read-crc)
[593.944640] Starting subtest: suspend-read-crc
[593.948902] Starting dynamic subtest: pipe-A-VGA-1
[612.026214] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.351s)
[612.105702] Starting dynamic subtest: pipe-B-VGA-1
[631.018503] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.453s)
[631.022325] Subtest suspend-read-crc: SUCCESS (4.821s)
[638.287281] Closing watchdogs
Done.