[51.987180] Initializing watchdogs
[51.987499]   /dev/watchdog0
[52.005526] [001/164] (960s left) i915_module_load (load)
[52.262824] Starting subtest: load
[55.686270] Subtest load: SUCCESS (3.424s)
[55.786541] [002/164] (956s left) core_auth (basic-auth)
[56.324365] Starting subtest: basic-auth
[56.337590] Subtest basic-auth: SUCCESS (0.010s)
[56.508264] [003/164] (956s left) debugfs_test (read_all_entries)
[56.777141] Starting subtest: read_all_entries
[56.934071] Subtest read_all_entries: SUCCESS (0.156s)
[57.469829] [004/164] (955s left) debugfs_test (basic-hwmon)
[57.709323] Starting subtest: basic-hwmon
[57.713125] Subtest basic-hwmon: SKIP (0.000s)
[58.237120] [005/164] (954s left) fbdev (eof)
[58.490167] Starting subtest: eof
[58.493286] Subtest eof: SUCCESS (0.003s)
[58.586864] [006/164] (954s left) fbdev (info)
[58.807751] Starting subtest: info
[58.810194] Subtest info: SUCCESS (0.000s)
[58.900914] [007/164] (954s left) fbdev (nullptr)
[59.139681] Starting subtest: nullptr
[59.141690] Subtest nullptr: SUCCESS (0.000s)
[59.218047] [008/164] (953s left) fbdev (read)
[59.452549] Starting subtest: read
[61.558549] Subtest read: SUCCESS (2.098s)
[61.642418] [009/164] (951s left) fbdev (write)
[61.873081] Starting subtest: write
[62.991737] Subtest write: SUCCESS (1.116s)
[63.087147] [010/164] (949s left) gem_basic (bad-close)
[63.320171] Starting subtest: bad-close
[63.326957] Subtest bad-close: SUCCESS (0.000s)
[63.417965] [011/164] (949s left) gem_basic (create-close)
[63.643655] Starting subtest: create-close
[63.648799] Subtest create-close: SUCCESS (0.000s)
[63.757643] [012/164] (949s left) gem_basic (create-fd-close)
[63.984887] Starting subtest: create-fd-close
[63.988273] Subtest create-fd-close: SUCCESS (0.001s)
[64.087729] [013/164] (949s left) gem_busy (busy@all-engines)
[64.368131] Starting subtest: busy
[64.369578] Starting dynamic subtest: all-engines
[64.521981] Dynamic subtest all-engines: SUCCESS (0.155s)
[64.526751] Subtest busy: SUCCESS (0.156s)
[64.958943] [014/164] (948s left) gem_close_race (basic-process)
[65.259154] Starting subtest: basic-process
[65.380695] Subtest basic-process: SUCCESS (0.127s)
[65.620770] [015/164] (947s left) gem_close_race (basic-threads)
[65.901414] Starting subtest: basic-threads
[67.127786] Subtest basic-threads: SUCCESS (1.229s)
[67.372313] [016/164] (946s left) gem_ctx_create (basic)
[67.676307] Starting subtest: basic
[67.678136] Subtest basic: SUCCESS (0.000s)
[67.907609] [017/164] (945s left) gem_ctx_create (basic-files)
[68.199077] Starting subtest: basic-files
[70.265206] Subtest basic-files: SUCCESS (2.065s)
[70.501953] [018/164] (942s left) gem_ctx_exec (basic)
[70.736905] Starting subtest: basic
[70.750951] Subtest basic: SUCCESS (0.011s)
[70.867630] [019/164] (942s left) gem_exec_basic (basic)
[71.128671] Starting subtest: basic
[71.131480] Starting dynamic subtest: rcs0-smem
[71.133635] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[71.165793] Starting dynamic subtest: bcs0-smem
[71.167278] Dynamic subtest bcs0-smem: SUCCESS (0.005s)
[71.185370] Starting dynamic subtest: vcs0-smem
[71.186873] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[71.205108] Starting dynamic subtest: vecs0-smem
[71.207436] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[71.209434] Subtest basic: SUCCESS (0.019s)
[71.387675] [020/164] (942s left) gem_exec_create (basic)
[71.663207] Starting subtest: basic
[71.666246] Starting dynamic subtest: smem
[73.744465] Dynamic subtest smem: SUCCESS (2.084s)
[73.745961] Subtest basic: SUCCESS (2.085s)
[73.972682] [021/164] (939s left) gem_exec_fence (basic-busy)
[74.405471] Starting subtest: basic-busy
[74.407331] Starting dynamic subtest: rcs0
[74.427437] Dynamic subtest rcs0: SUCCESS (0.026s)
[74.463544] Starting dynamic subtest: bcs0
[74.468293] Dynamic subtest bcs0: SUCCESS (0.027s)
[74.499262] Starting dynamic subtest: vcs0
[74.509074] Dynamic subtest vcs0: SUCCESS (0.031s)
[74.530357] Starting dynamic subtest: vecs0
[74.534350] Dynamic subtest vecs0: SUCCESS (0.030s)
[74.536874] Subtest basic-busy: SUCCESS (0.117s)
[75.307832] [022/164] (938s left) gem_exec_fence (basic-wait)
[75.744311] Starting subtest: basic-wait
[75.746661] Starting dynamic subtest: rcs0
[75.763225] Dynamic subtest rcs0: SUCCESS (0.023s)
[75.787923] Starting dynamic subtest: bcs0
[75.789840] Dynamic subtest bcs0: SUCCESS (0.027s)
[75.810684] Starting dynamic subtest: vcs0
[75.812330] Dynamic subtest vcs0: SUCCESS (0.021s)
[75.834211] Starting dynamic subtest: vecs0
[75.835678] Dynamic subtest vecs0: SUCCESS (0.020s)
[75.837155] Subtest basic-wait: SUCCESS (0.095s)
[76.477462] [023/164] (937s left) gem_exec_fence (basic-await)
[76.909611] Starting subtest: basic-await
[76.912227] Starting dynamic subtest: rcs0
[77.094975] Dynamic subtest rcs0: SUCCESS (0.185s)
[77.118653] Starting dynamic subtest: bcs0
[77.285389] Dynamic subtest bcs0: SUCCESS (0.188s)
[77.308364] Starting dynamic subtest: vcs0
[77.468904] Dynamic subtest vcs0: SUCCESS (0.182s)
[77.493326] Starting dynamic subtest: vecs0
[77.646297] Dynamic subtest vecs0: SUCCESS (0.177s)
[77.648433] Subtest basic-await: SUCCESS (0.737s)
[78.289645] [024/164] (935s left) gem_exec_fence (nb-await)
[78.722806] Starting subtest: nb-await
[78.724345] Starting dynamic subtest: rcs0
[78.805326] Dynamic subtest rcs0: SUCCESS (0.084s)
[78.827922] Starting dynamic subtest: bcs0
[78.885690] Dynamic subtest bcs0: SUCCESS (0.077s)
[78.907634] Starting dynamic subtest: vcs0
[78.972537] Dynamic subtest vcs0: SUCCESS (0.081s)
[78.997563] Starting dynamic subtest: vecs0
[79.045352] Dynamic subtest vecs0: SUCCESS (0.074s)
[79.046811] Subtest nb-await: SUCCESS (0.323s)
[79.672449] [025/164] (934s left) gem_exec_gttfill (basic)
[79.940740] Starting subtest: basic
[81.771929] Subtest basic: SKIP (1.811s)
[82.037987] [026/164] (931s left) gem_exec_parallel (engines)
[82.466988] Starting subtest: engines
[82.473501] Starting dynamic subtest: basic
[87.612510] Dynamic subtest basic: SUCCESS (5.148s)
[87.635295] Starting dynamic subtest: contexts
[95.971116] Dynamic subtest contexts: SUCCESS (8.352s)
[95.998714] Starting dynamic subtest: fds
[109.554924] Dynamic subtest fds: SUCCESS (13.586s)
[109.580109] Starting dynamic subtest: userptr
[115.073662] Dynamic subtest userptr: SUCCESS (5.519s)
[115.075267] Subtest engines: SUCCESS (32.609s)
[115.351161] [027/164] (898s left) gem_exec_store (basic)
[115.626115] Starting subtest: basic
[115.688448] Subtest basic: SUCCESS (0.066s)
[115.926952] [028/164] (898s left) gem_flink_basic (bad-flink)
[116.152959] Starting subtest: bad-flink
[116.155104] Subtest bad-flink: SUCCESS (0.000s)
[116.261869] [029/164] (897s left) gem_flink_basic (bad-open)
[116.487718] Starting subtest: bad-open
[116.495098] Subtest bad-open: SUCCESS (0.000s)
[116.607453] [030/164] (897s left) gem_flink_basic (basic)
[116.833737] Starting subtest: basic
[116.835300] Subtest basic: SUCCESS (0.000s)
[116.942374] [031/164] (897s left) gem_flink_basic (double-flink)
[117.171188] Starting subtest: double-flink
[117.174359] Subtest double-flink: SUCCESS (0.000s)
[117.289770] [032/164] (896s left) gem_flink_basic (flink-lifetime)
[117.519540] Starting subtest: flink-lifetime
[117.526178] Subtest flink-lifetime: SUCCESS (0.005s)
[117.638948] [033/164] (896s left) gem_huc_copy (huc-copy)
[117.881313] Subtest huc-copy: SKIP (0.000s)
[117.946519] [034/164] (896s left) gem_linear_blits (basic)
[118.502492] Subtest basic: SKIP (0.000s)
[118.645525] [035/164] (895s left) gem_mmap (basic)
[119.038773] Starting subtest: basic
[119.052486] Subtest basic: SUCCESS (0.001s)
[119.142203] [036/164] (895s left) gem_mmap_gtt (basic)
[119.377504] Starting subtest: basic
[119.380834] Subtest basic: SUCCESS (0.002s)
[119.481109] [037/164] (895s left) gem_render_linear_blits (basic)
[119.724580] Starting subtest: basic
[119.841283] Subtest basic: SUCCESS (0.113s)
[119.911671] [038/164] (894s left) gem_render_tiled_blits (basic)
[120.151652] Starting subtest: basic
[120.292807] Subtest basic: SUCCESS (0.130s)
[120.363317] [039/164] (894s left) gem_ringfill (basic-all)
[120.789699] Starting subtest: basic-all
[122.211421] Subtest basic-all: SUCCESS (1.419s)
[122.332143] [040/164] (892s left) gem_softpin (allocator-basic)
[122.572143] Starting subtest: allocator-basic
[122.863392] Subtest allocator-basic: SUCCESS (0.283s)
[123.009626] [041/164] (891s left) gem_softpin (allocator-basic-reserve)
[123.255304] Starting subtest: allocator-basic-reserve
[123.559773] Subtest allocator-basic-reserve: SUCCESS (0.297s)
[123.740971] [042/164] (891s left) gem_softpin (safe-alignment)
[123.988857] Starting subtest: safe-alignment
[124.035087] Subtest safe-alignment: SUCCESS (0.046s)
[124.158087] [043/164] (890s left) gem_sync (basic-all)
[124.442572] Starting subtest: basic-all
[127.183128] Subtest basic-all: SUCCESS (2.741s)
[127.439253] [044/164] (887s left) gem_sync (basic-each)
[127.711057] Starting subtest: basic-each
[130.240674] Subtest basic-each: SUCCESS (2.531s)
[130.500976] [045/164] (884s left) gem_tiled_blits (basic)
[131.002962] Subtest basic: SKIP (0.000s)
[131.101908] [046/164] (883s left) gem_tiled_fence_blits (basic)
[131.783927] Starting subtest: basic
[131.856673] Subtest basic: SUCCESS (0.069s)
[132.003311] [047/164] (883s left) gem_tiled_pread_basic
[133.206420] [048/164] (881s left) gem_wait (busy@all-engines)
[133.499324] Starting subtest: busy
[133.502454] Starting dynamic subtest: all-engines
[134.027594] Dynamic subtest all-engines: SUCCESS (0.529s)
[134.029044] Subtest busy: SUCCESS (0.530s)
[134.345263] [049/164] (880s left) gem_wait (wait@all-engines)
[134.638558] Starting subtest: wait
[134.642884] Starting dynamic subtest: all-engines
[135.679155] Dynamic subtest all-engines: SUCCESS (1.040s)
[135.684850] Subtest wait: SUCCESS (1.041s)
[135.992082] [050/164] (879s left) i915_getparams_basic (basic-eu-total)
[136.224568] Starting subtest: basic-eu-total
[136.228234] Subtest basic-eu-total: SUCCESS (0.000s)
[136.332779] [051/164] (879s left) i915_getparams_basic (basic-subslice-total)
[136.558889] Starting subtest: basic-subslice-total
[136.563408] Subtest basic-subslice-total: SUCCESS (0.000s)
[136.662804] [052/164] (878s left) i915_hangman (error-state-basic)
[136.917978] Starting subtest: error-state-basic
[136.941432] Subtest error-state-basic: SUCCESS (0.018s)
[137.041159] [053/164] (878s left) i915_pciid
[137.375380] [054/164] (878s left) kms_addfb_basic (addfb25-4-tiled)
[138.048848] Starting subtest: addfb25-4-tiled
[138.050459] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[138.156978] [055/164] (877s left) kms_addfb_basic (addfb25-bad-modifier)
[138.392925] Starting subtest: addfb25-bad-modifier
[138.394654] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[138.923773] [056/164] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[139.155915] Starting subtest: addfb25-framebuffer-vs-set-tiling
[139.157495] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[139.691682] [057/164] (875s left) kms_addfb_basic (addfb25-modifier-no-flag)
[139.923259] Starting subtest: addfb25-modifier-no-flag
[139.925932] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[140.458289] [058/164] (875s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[140.690625] Starting subtest: addfb25-x-tiled-legacy
[140.694362] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[141.226856] [059/164] (874s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[141.455866] Starting subtest: addfb25-x-tiled-mismatch-legacy
[141.459308] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[141.991352] [060/164] (873s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[142.652235] Starting subtest: addfb25-yf-tiled-legacy
[142.654562] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.004s)
[142.773221] [061/164] (873s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[143.405812] Starting subtest: addfb25-y-tiled-legacy
[143.407504] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[143.524482] [062/164] (872s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[144.180727] Starting subtest: addfb25-y-tiled-small-legacy
[144.185511] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[144.293232] [063/164] (871s left) kms_addfb_basic (bad-pitch-0)
[144.522164] Starting subtest: bad-pitch-0
[144.523894] Subtest bad-pitch-0: SUCCESS (0.000s)
[145.073200] [064/164] (870s left) kms_addfb_basic (bad-pitch-1024)
[145.307978] Starting subtest: bad-pitch-1024
[145.309616] Subtest bad-pitch-1024: SUCCESS (0.000s)
[145.841356] [065/164] (870s left) kms_addfb_basic (bad-pitch-128)
[146.069582] Starting subtest: bad-pitch-128
[146.070981] Subtest bad-pitch-128: SUCCESS (0.000s)
[146.590622] [066/164] (869s left) kms_addfb_basic (bad-pitch-256)
[146.826712] Starting subtest: bad-pitch-256
[146.831329] Subtest bad-pitch-256: SUCCESS (0.000s)
[147.373727] [067/164] (868s left) kms_addfb_basic (bad-pitch-32)
[147.614623] Starting subtest: bad-pitch-32
[147.619544] Subtest bad-pitch-32: SUCCESS (0.000s)
[148.141466] [068/164] (868s left) kms_addfb_basic (bad-pitch-63)
[148.373790] Starting subtest: bad-pitch-63
[148.375322] Subtest bad-pitch-63: SUCCESS (0.000s)
[148.946950] [069/164] (867s left) kms_addfb_basic (bad-pitch-65536)
[149.183397] Starting subtest: bad-pitch-65536
[149.185753] Subtest bad-pitch-65536: SUCCESS (0.001s)
[149.725282] [070/164] (866s left) kms_addfb_basic (bad-pitch-999)
[149.958981] Starting subtest: bad-pitch-999
[149.961141] Subtest bad-pitch-999: SUCCESS (0.000s)
[150.493439] [071/164] (865s left) kms_addfb_basic (basic)
[150.724524] Starting subtest: basic
[150.727063] Subtest basic: SUCCESS (0.000s)
[151.241828] [072/164] (865s left) kms_addfb_basic (basic-x-tiled-legacy)
[151.475850] Starting subtest: basic-x-tiled-legacy
[151.480652] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[151.992948] [073/164] (864s left) kms_addfb_basic (basic-y-tiled-legacy)
[152.225926] Starting subtest: basic-y-tiled-legacy
[152.227931] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[152.775631] [074/164] (863s left) kms_addfb_basic (bo-too-small)
[153.448843] Starting subtest: bo-too-small
[153.450656] Subtest bo-too-small: SUCCESS (0.001s)
[153.612603] [075/164] (863s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[154.283271] Starting subtest: bo-too-small-due-to-tiling
[154.285204] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[154.395140] [076/164] (862s left) kms_addfb_basic (clobberred-modifier)
[154.620853] Starting subtest: clobberred-modifier
[154.623617] Subtest clobberred-modifier: SUCCESS (0.000s)
[155.157599] [077/164] (861s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[155.394567] Starting subtest: framebuffer-vs-set-tiling
[155.396869] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[155.941577] [078/164] (860s left) kms_addfb_basic (invalid-get-prop)
[156.173905] Starting subtest: invalid-get-prop
[156.176236] Subtest invalid-get-prop: SUCCESS (0.000s)
[156.709793] [079/164] (860s left) kms_addfb_basic (invalid-get-prop-any)
[156.936505] Starting subtest: invalid-get-prop-any
[156.938207] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[157.477539] [080/164] (859s left) kms_addfb_basic (invalid-set-prop)
[157.712879] Starting subtest: invalid-set-prop
[157.715830] Subtest invalid-set-prop: SUCCESS (0.000s)
[158.257492] [081/164] (858s left) kms_addfb_basic (invalid-set-prop-any)
[158.493825] Starting subtest: invalid-set-prop-any
[158.495442] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[159.041684] [082/164] (858s left) kms_addfb_basic (no-handle)
[159.269260] Starting subtest: no-handle
[159.271855] Subtest no-handle: SUCCESS (0.000s)
[159.791900] [083/164] (857s left) kms_addfb_basic (size-max)
[160.448710] Starting subtest: size-max
[160.451501] Subtest size-max: SUCCESS (0.000s)
[160.556875] [084/164] (856s left) kms_addfb_basic (small-bo)
[161.194467] Starting subtest: small-bo
[161.196286] Subtest small-bo: SUCCESS (0.000s)
[161.306491] [085/164] (855s left) kms_addfb_basic (tile-pitch-mismatch)
[161.538065] Starting subtest: tile-pitch-mismatch
[161.541128] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[162.073958] [086/164] (855s left) kms_addfb_basic (too-high)
[162.728769] Starting subtest: too-high
[162.731662] Subtest too-high: SUCCESS (0.005s)
[162.842951] [087/164] (854s left) kms_addfb_basic (too-wide)
[163.500253] Starting subtest: too-wide
[163.502329] Subtest too-wide: SUCCESS (0.000s)
[163.658903] [088/164] (853s left) kms_addfb_basic (unused-handle)
[163.902769] Starting subtest: unused-handle
[163.905840] Subtest unused-handle: SUCCESS (0.000s)
[164.457493] [089/164] (853s left) kms_addfb_basic (unused-modifier)
[164.682848] Starting subtest: unused-modifier
[164.686283] Subtest unused-modifier: SUCCESS (0.000s)
[165.256613] [090/164] (852s left) kms_addfb_basic (unused-offsets)
[165.488899] Starting subtest: unused-offsets
[165.491616] Subtest unused-offsets: SUCCESS (0.000s)
[166.008510] [091/164] (851s left) kms_addfb_basic (unused-pitches)
[166.231253] Starting subtest: unused-pitches
[166.233568] Subtest unused-pitches: SUCCESS (0.000s)
[166.775316] [092/164] (850s left) kms_busy (basic)
[167.452098] Starting subtest: basic
[167.454369] Starting dynamic subtest: flip
[168.536142] Dynamic subtest flip: SUCCESS (1.085s)
[168.583569] Starting dynamic subtest: modeset
[171.220643] Dynamic subtest modeset: SUCCESS (2.684s)
[171.224092] Subtest basic: SUCCESS (3.778s)
[171.742351] [093/164] (845s left) kms_prop_blob (basic)
[171.977255] Starting subtest: basic
[171.980986] Subtest basic: SUCCESS (0.000s)
[172.087454] [094/164] (845s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[172.765719] Starting subtest: basic-busy-flip-before-cursor-atomic
[173.975941] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.209s)
[174.504380] [095/164] (843s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[175.180378] Starting subtest: basic-busy-flip-before-cursor-legacy
[176.460798] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.266s)
[176.953743] [096/164] (840s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[177.627406] Starting subtest: basic-flip-after-cursor-atomic
[178.884067] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.244s)
[179.376254] [097/164] (838s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[180.048159] Starting subtest: basic-flip-after-cursor-legacy
[181.303311] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.260s)
[181.795582] [098/164] (836s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[182.501976] Starting subtest: basic-flip-after-cursor-varying-size
[183.680109] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.177s)
[184.184979] [099/164] (833s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[184.879612] Starting subtest: basic-flip-before-cursor-atomic
[186.090224] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.201s)
[186.601828] [100/164] (831s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[187.301651] Starting subtest: basic-flip-before-cursor-legacy
[188.474736] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.180s)
[188.979667] [101/164] (829s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[189.662742] Starting subtest: basic-flip-before-cursor-varying-size
[190.879457] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.210s)
[191.386501] [102/164] (826s left) kms_flip (basic-flip-vs-dpms)
[191.858612] Starting subtest: basic-flip-vs-dpms
[191.884194] Starting dynamic subtest: C-HDMI-A2
[194.852294] Dynamic subtest C-HDMI-A2: SUCCESS (2.968s)
[194.854545] Subtest basic-flip-vs-dpms: SUCCESS (2.995s)
[195.357541] [103/164] (822s left) kms_flip (basic-flip-vs-modeset)
[195.839160] Starting subtest: basic-flip-vs-modeset
[195.856659] Starting dynamic subtest: C-HDMI-A2
[198.686292] Dynamic subtest C-HDMI-A2: SUCCESS (2.822s)
[198.694695] Subtest basic-flip-vs-modeset: SUCCESS (2.851s)
[199.370627] [104/164] (818s left) kms_flip (basic-flip-vs-wf_vblank)
[199.850482] Starting subtest: basic-flip-vs-wf_vblank
[199.860602] Starting dynamic subtest: C-HDMI-A2
[202.806323] Dynamic subtest C-HDMI-A2: SUCCESS (2.937s)
[202.807761] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.957s)
[202.971921] [105/164] (815s left) kms_flip (basic-plain-flip)
[203.452513] Starting subtest: basic-plain-flip
[203.467453] Starting dynamic subtest: C-HDMI-A2
[206.041533] Dynamic subtest C-HDMI-A2: SUCCESS (2.565s)
[206.042988] Subtest basic-plain-flip: SUCCESS (2.589s)
[206.209074] [106/164] (812s left) kms_force_connector_basic (force-connector-state)
[206.573167] Starting subtest: force-connector-state
[207.670569] Subtest force-connector-state: SUCCESS (1.098s)
[208.979185] [107/164] (809s left) kms_force_connector_basic (force-edid)
[209.349897] Starting subtest: force-edid
[209.468630] Subtest force-edid: SUCCESS (0.106s)
[210.262751] [108/164] (808s left) kms_force_connector_basic (force-load-detect)
[210.640275] Starting subtest: force-load-detect
[210.647193] Subtest force-load-detect: SKIP (0.000s)
[211.161970] [109/164] (807s left) kms_force_connector_basic (prune-stale-modes)
[211.551834] Starting subtest: prune-stale-modes
[211.631946] Subtest prune-stale-modes: SUCCESS (0.071s)
[212.429885] [110/164] (806s left) kms_frontbuffer_tracking (basic)
[213.186385] Starting subtest: basic
[217.324102] Subtest basic: SUCCESS (4.135s)
[217.464820] [111/164] (801s left) kms_hdmi_inject (inject-audio)
[217.817615] Starting subtest: inject-audio
[218.307218] Subtest inject-audio: FAIL (0.417s)
[219.163562] [112/164] (799s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[219.868042] Starting subtest: compare-crc-sanitycheck-xr24
[219.876408] Starting dynamic subtest: pipe-C-HDMI-A-2
[220.399635] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.519s)
[220.401308] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.533s)
[220.924835] [113/164] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[221.616402] Starting subtest: compare-crc-sanitycheck-nv12
[221.618957] Starting dynamic subtest: pipe-C-HDMI-A-2
[221.622960] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[221.627920] Subtest compare-crc-sanitycheck-nv12: SKIP (0.013s)
[221.745422] [114/164] (797s left) kms_pipe_crc_basic (hang-read-crc)
[222.456118] Starting subtest: hang-read-crc
[222.459675] Starting dynamic subtest: pipe-C-HDMI-A-2
[223.971816] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.515s)
[223.981285] Subtest hang-read-crc: SUCCESS (1.530s)
[224.465130] [115/164] (794s left) kms_pipe_crc_basic (nonblocking-crc)
[225.170574] Starting subtest: nonblocking-crc
[225.173939] Starting dynamic subtest: pipe-C-HDMI-A-2
[225.885983] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.717s)
[225.889213] Subtest nonblocking-crc: SUCCESS (0.728s)
[226.391541] [116/164] (792s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[227.097468] Starting subtest: nonblocking-crc-frame-sequence
[227.103552] Starting dynamic subtest: pipe-C-HDMI-A-2
[227.807421] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.699s)
[227.808998] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.713s)
[228.322210] [117/164] (790s left) kms_pipe_crc_basic (read-crc)
[229.037879] Starting subtest: read-crc
[229.050183] Starting dynamic subtest: pipe-C-HDMI-A-2
[229.670506] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.620s)
[229.674149] Subtest read-crc: SUCCESS (0.634s)
[230.181838] [118/164] (788s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[230.900823] Starting subtest: read-crc-frame-sequence
[230.902319] Starting dynamic subtest: pipe-C-HDMI-A-2
[231.475978] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.582s)
[231.479983] Subtest read-crc-frame-sequence: SUCCESS (0.589s)
[231.938273] [119/164] (787s left) kms_pm_backlight (basic-brightness)
[232.630406] Subtest basic-brightness: SKIP (0.000s)
[232.714332] [120/164] (786s left) kms_psr (primary_page_flip)
[232.947898] Subtest primary_page_flip: SKIP (0.000s)
[233.029847] [121/164] (786s left) kms_psr (cursor_plane_move)
[233.274294] Subtest cursor_plane_move: SKIP (0.000s)
[233.343678] [122/164] (786s left) kms_psr (sprite_plane_onoff)
[233.575588] Subtest sprite_plane_onoff: SKIP (0.000s)
[233.649460] [123/164] (785s left) kms_psr (primary_mmap_gtt)
[233.885635] Subtest primary_mmap_gtt: SKIP (0.000s)
[233.962384] [124/164] (785s left) kms_setmode (basic-clone-single-crtc)
[234.199695] Starting subtest: basic-clone-single-crtc
[234.206392] Subtest basic-clone-single-crtc: SKIP (0.001s)
[234.329642] [125/164] (785s left) i915_pm_rpm (basic-pci-d3-state)
[236.713334] Starting subtest: basic-pci-d3-state
[237.038159] Subtest basic-pci-d3-state: SUCCESS (0.309s)
[237.359403] [126/164] (782s left) i915_pm_rpm (basic-rte)
[237.589054] Starting subtest: basic-rte
[240.115718] Subtest basic-rte: SUCCESS (2.525s)
[241.400752] [127/164] (778s left) i915_pm_rps (basic-api)
[241.657151] Starting subtest: basic-api
[241.673123] Subtest basic-api: SUCCESS (0.014s)
[241.795367] [128/164] (777s left) prime_self_import (basic-llseek-bad)
[242.023137] Starting subtest: basic-llseek-bad
[242.033172] Subtest basic-llseek-bad: SUCCESS (0.010s)
[242.148916] [129/164] (777s left) prime_self_import (basic-llseek-size)
[242.373411] Starting subtest: basic-llseek-size
[242.382748] Subtest basic-llseek-size: SUCCESS (0.012s)
[242.497383] [130/164] (777s left) prime_self_import (basic-with_fd_dup)
[242.727568] Starting subtest: basic-with_fd_dup
[242.739864] Subtest basic-with_fd_dup: SUCCESS (0.013s)
[242.850466] [131/164] (777s left) prime_self_import (basic-with_one_bo)
[243.081710] Starting subtest: basic-with_one_bo
[243.100949] Subtest basic-with_one_bo: SUCCESS (0.024s)
[243.228592] [132/164] (776s left) prime_self_import (basic-with_one_bo_two_files)
[243.489113] Starting subtest: basic-with_one_bo_two_files
[243.499690] Subtest basic-with_one_bo_two_files: SUCCESS (0.013s)
[243.612247] [133/164] (776s left) prime_self_import (basic-with_two_bos)
[243.837107] Starting subtest: basic-with_two_bos
[243.847882] Subtest basic-with_two_bos: SUCCESS (0.013s)
[243.963308] [134/164] (776s left) prime_vgem (basic-fence-flip)
[244.231094] Starting subtest: basic-fence-flip
[244.997492] Subtest basic-fence-flip: SKIP (0.757s)
[245.145985] [135/164] (775s left) prime_vgem (basic-fence-mmap)
[245.411556] Starting subtest: basic-fence-mmap
[245.526384] Subtest basic-fence-mmap: SUCCESS (0.112s)
[245.655887] [136/164] (774s left) prime_vgem (basic-fence-read)
[245.914657] Starting subtest: basic-fence-read
[246.095847] Subtest basic-fence-read: SUCCESS (0.178s)
[246.218500] [137/164] (774s left) prime_vgem (basic-gtt)
[246.478545] Starting subtest: basic-gtt
[246.528639] Subtest basic-gtt: SUCCESS (0.050s)
[246.670275] [138/164] (773s left) prime_vgem (basic-read)
[246.927224] Starting subtest: basic-read
[247.013652] Subtest basic-read: SUCCESS (0.080s)
[247.137283] [139/164] (773s left) prime_vgem (basic-write)
[247.401117] Starting subtest: basic-write
[247.500351] Subtest basic-write: SUCCESS (0.098s)
[247.618942] [140/164] (772s left) vgem_basic (setversion)
[247.860146] Starting subtest: setversion
[247.863542] Subtest setversion: SUCCESS (0.000s)
[247.946686] [141/164] (772s left) vgem_basic (create)
[248.197679] Starting subtest: create
[248.199653] Subtest create: SUCCESS (0.001s)
[248.298615] [142/164] (772s left) vgem_basic (debugfs)
[248.541090] Starting subtest: debugfs
[248.542777] Subtest debugfs: SUCCESS (0.002s)
[248.628634] [143/164] (772s left) vgem_basic (dmabuf-export)
[248.881032] Starting subtest: dmabuf-export
[248.885030] Subtest dmabuf-export: SUCCESS (0.008s)
[248.994212] [144/164] (771s left) vgem_basic (dmabuf-fence)
[249.247707] Starting subtest: dmabuf-fence
[249.258166] Subtest dmabuf-fence: SUCCESS (0.007s)
[249.349714] [145/164] (771s left) vgem_basic (dmabuf-fence-before)
[249.591700] Starting subtest: dmabuf-fence-before
[249.593278] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[249.682569] [146/164] (771s left) vgem_basic (dmabuf-mmap)
[249.925533] Starting subtest: dmabuf-mmap
[249.970214] Subtest dmabuf-mmap: SUCCESS (0.044s)
[250.066658] [147/164] (770s left) vgem_basic (mmap)
[250.309450] Starting subtest: mmap
[250.340440] Subtest mmap: SUCCESS (0.031s)
[250.437215] [148/164] (770s left) vgem_basic (second-client)
[250.674614] Starting subtest: second-client
[250.711132] Subtest second-client: SUCCESS (0.035s)
[250.798941] [149/164] (770s left) vgem_basic (sysfs)
[251.040468] Starting subtest: sysfs
[251.042371] Subtest sysfs: SUCCESS (0.002s)
[251.151856] [150/164] (769s left) core_hotunplug (unbind-rebind)
[251.490280] Starting subtest: unbind-rebind
[256.414899] Subtest unbind-rebind: SUCCESS (4.924s)
[256.579349] [151/164] (764s left) vgem_basic (unload)
[256.809655] Starting subtest: unload
[285.934416] Subtest unload: SUCCESS (29.119s)
[286.148941] [152/164] (735s left) i915_module_load (reload)
[286.369503] Starting subtest: reload
[291.168355] Subtest reload: SUCCESS (4.790s)
[291.335887] [153/164] (730s left) gem_lmem_swapping (basic)
[291.739987] Subtest basic: SKIP (0.000s)
[291.832434] [154/164] (729s left) gem_lmem_swapping (parallel-random-engines)
[292.201876] Subtest parallel-random-engines: SKIP (0.000s)
[292.289231] [155/164] (729s left) gem_lmem_swapping (random-engines)
[292.534144] Subtest random-engines: SKIP (0.000s)
[292.608612] [156/164] (729s left) gem_lmem_swapping (verify-random)
[292.853846] Subtest verify-random: SKIP (0.000s)
[292.925961] [157/164] (728s left) i915_pm_rpm (module-reload)
[295.640634] Starting subtest: module-reload
[309.726889] Subtest module-reload: SUCCESS (14.086s)
[309.779521] [158/164] (711s left) i915_selftest (live)
[310.041185] Starting subtest: live
[310.044136] Starting dynamic subtest: sanitycheck
[311.909599] Dynamic subtest sanitycheck: SUCCESS (1.866s)
[311.950150] Starting dynamic subtest: uncore
[313.713463] Dynamic subtest uncore: SUCCESS (1.796s)
[313.735424] Starting dynamic subtest: workarounds
[315.735038] Dynamic subtest workarounds: SUCCESS (2.017s)
[315.754740] Starting dynamic subtest: gt_engines
[317.969430] Dynamic subtest gt_engines: SUCCESS (2.231s)
[317.988739] Starting dynamic subtest: gt_timelines
[346.135141] Dynamic subtest gt_timelines: SUCCESS (28.160s)
[346.161090] Starting dynamic subtest: gt_contexts
[348.170868] Dynamic subtest gt_contexts: SUCCESS (2.029s)
[348.189902] Starting dynamic subtest: gt_lrc
[353.202342] Dynamic subtest gt_lrc: SUCCESS (5.028s)
[353.221272] Starting dynamic subtest: gt_mocs
[355.060091] Dynamic subtest gt_mocs: SUCCESS (1.849s)
[355.090957] Starting dynamic subtest: gt_pm
[357.994351] Dynamic subtest gt_pm: SUCCESS (2.929s)
[358.014289] Starting dynamic subtest: gt_heartbeat
[359.996292] Dynamic subtest gt_heartbeat: SUCCESS (1.999s)
[360.021752] Starting dynamic subtest: gt_tlb
[362.094406] Dynamic subtest gt_tlb: SUCCESS (2.094s)
[362.113576] Starting dynamic subtest: requests
[370.473895] Dynamic subtest requests: SUCCESS (8.376s)
[370.493506] Starting dynamic subtest: migrate
[375.963670] Dynamic subtest migrate: SUCCESS (5.485s)
[375.982779] Starting dynamic subtest: active
[377.792718] Dynamic subtest active: SUCCESS (1.827s)
[377.812370] Starting dynamic subtest: objects
[381.553340] Dynamic subtest objects: SUCCESS (3.752s)
[381.573988] Starting dynamic subtest: mman
[391.732522] Dynamic subtest mman: SUCCESS (10.177s)
[391.751739] Starting dynamic subtest: dmabuf
[393.603327] Dynamic subtest dmabuf: SUCCESS (1.861s)
[393.654082] Starting dynamic subtest: vma
[395.547063] Dynamic subtest vma: SUCCESS (1.944s)
[395.566627] Starting dynamic subtest: coherency
[401.090980] Dynamic subtest coherency: SUCCESS (5.541s)
[401.111153] Starting dynamic subtest: gtt
[410.349557] Dynamic subtest gtt: SUCCESS (9.255s)
[410.368799] Starting dynamic subtest: gem
[413.120233] Dynamic subtest gem: SUCCESS (2.764s)
[413.139348] Starting dynamic subtest: evict
[421.154479] Dynamic subtest evict: SUCCESS (8.029s)
[421.173624] Starting dynamic subtest: hugepages
[423.462605] Dynamic subtest hugepages: SUCCESS (2.304s)
[423.482972] Starting dynamic subtest: gem_contexts
[447.863209] Dynamic subtest gem_contexts: SUCCESS (24.395s)
[447.882503] Starting dynamic subtest: client
[449.787140] Dynamic subtest client: SUCCESS (1.922s)
[449.807821] Starting dynamic subtest: gem_migrate
[451.602189] Dynamic subtest gem_migrate: SUCCESS (1.805s)
[451.661260] Starting dynamic subtest: reset
[461.556295] Dynamic subtest reset: SUCCESS (9.951s)
[461.575737] Starting dynamic subtest: memory_region
[463.385786] Dynamic subtest memory_region: SUCCESS (1.827s)
[463.413227] Starting dynamic subtest: hangcheck
[488.436808] Dynamic subtest hangcheck: SUCCESS (25.044s)
[488.457777] Starting dynamic subtest: execlists
[500.122172] Dynamic subtest execlists: SUCCESS (11.678s)
[500.141649] Starting dynamic subtest: ring_submission
[501.991142] Dynamic subtest ring_submission: SUCCESS (1.860s)
[502.042823] Starting dynamic subtest: perf
[504.160648] Dynamic subtest perf: SUCCESS (2.166s)
[504.179934] Starting dynamic subtest: slpc
[506.035849] Dynamic subtest slpc: SUCCESS (1.870s)
[506.055081] Starting dynamic subtest: guc
[507.848493] Dynamic subtest guc: SUCCESS (1.811s)
[507.875356] Starting dynamic subtest: guc_multi_lrc
[509.593265] Dynamic subtest guc_multi_lrc: SUCCESS (1.738s)
[509.663636] Starting dynamic subtest: guc_hang
[511.478535] Dynamic subtest guc_hang: SUCCESS (1.882s)
[511.525878] Starting dynamic subtest: late_gt_pm
[513.461111] Dynamic subtest late_gt_pm: SUCCESS (1.977s)
[513.462536] Subtest live: SUCCESS (203.422s)
[513.526326] [159/164] (508s left) dmabuf (all-tests)
[513.768285] Starting subtest: all-tests
[513.770106] Starting dynamic subtest: sanitycheck
[513.842501] Dynamic subtest sanitycheck: SUCCESS (0.070s)
[513.885057] Starting dynamic subtest: dma_fence
[514.070378] Dynamic subtest dma_fence: SUCCESS (0.215s)
[514.101272] Starting dynamic subtest: dma_fence_chain
[545.491541] Dynamic subtest dma_fence_chain: SUCCESS (31.411s)
[545.530804] Starting dynamic subtest: dma_fence_unwrap
[545.567149] Dynamic subtest dma_fence_unwrap: SUCCESS (0.074s)
[545.612906] Starting dynamic subtest: dma_resv
[545.650063] Dynamic subtest dma_resv: SUCCESS (0.073s)
[545.653340] Subtest all-tests: SUCCESS (31.885s)
[545.718878] [160/164] (476s left) i915_suspend (basic-s2idle-without-i915)
[545.941853] Starting subtest: basic-s2idle-without-i915
[569.542574] Subtest basic-s2idle-without-i915: SUCCESS (8.593s)
[575.259522] [161/164] (466s left) i915_suspend (basic-s3-without-i915)
[575.492150] Starting subtest: basic-s3-without-i915
[597.486852] Subtest basic-s3-without-i915: SUCCESS (6.832s)
[600.084130] [162/164] (459s left) gem_exec_suspend (basic-s0)
[600.396736] Starting subtest: basic-S0
[600.398969] Starting dynamic subtest: smem
[624.107320] Dynamic subtest smem: SUCCESS (8.869s)
[624.108785] Subtest basic-S0: SUCCESS (8.873s)
[629.345549] [163/164] (449s left) gem_exec_suspend (basic-s3)
[629.621879] Starting subtest: basic-S3
[629.626961] Starting dynamic subtest: smem
[653.957687] Dynamic subtest smem: SUCCESS (8.923s)
[653.960608] Subtest basic-S3: SUCCESS (8.927s)
[656.177855] [164/164] (440s left) kms_pipe_crc_basic (suspend-read-crc)
[656.898004] Starting subtest: suspend-read-crc
[656.917215] Starting dynamic subtest: pipe-C-HDMI-A-2
[677.801503] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.272s)
[677.802902] Subtest suspend-read-crc: SUCCESS (5.284s)
[683.134175] Closing watchdogs
Done.