[39.139847] Initializing watchdogs
[39.139989]   /dev/watchdog0
[39.149628] [001/160] (960s left) i915_module_load (load)
[39.250313] Starting subtest: load
[43.476030] Subtest load: SUCCESS (4.226s)
[43.499407] [002/160] (956s left) core_auth (basic-auth)
[43.620638] Starting subtest: basic-auth
[43.623103] Subtest basic-auth: SUCCESS (0.003s)
[43.717186] [003/160] (955s left) debugfs_test (read_all_entries)
[43.823053] Starting subtest: read_all_entries
[43.912919] Subtest read_all_entries: SUCCESS (0.089s)
[44.030357] [004/160] (955s left) debugfs_test (basic-hwmon)
[44.136636] Starting subtest: basic-hwmon
[44.138794] Subtest basic-hwmon: SKIP (0.000s)
[44.242756] [005/160] (955s left) fbdev (eof)
[44.363073] Starting subtest: eof
[44.368335] Subtest eof: SUCCESS (0.001s)
[44.448982] [006/160] (955s left) fbdev (info)
[44.539550] Starting subtest: info
[44.540667] Subtest info: SUCCESS (0.000s)
[44.645445] [007/160] (955s left) fbdev (nullptr)
[44.744677] Starting subtest: nullptr
[44.745943] Subtest nullptr: SUCCESS (0.000s)
[44.812964] [008/160] (955s left) fbdev (read)
[44.911828] Starting subtest: read
[51.998063] Subtest read: SUCCESS (7.056s)
[52.036642] [009/160] (947s left) fbdev (write)
[52.135902] Starting subtest: write
[55.916494] Subtest write: SUCCESS (3.747s)
[55.955490] [010/160] (943s left) gem_basic (bad-close)
[56.056762] Starting subtest: bad-close
[56.059689] Subtest bad-close: SUCCESS (0.000s)
[56.143306] [011/160] (943s left) gem_basic (create-close)
[56.246826] Starting subtest: create-close
[56.249124] Subtest create-close: SUCCESS (0.000s)
[56.345371] [012/160] (943s left) gem_basic (create-fd-close)
[56.448472] Starting subtest: create-fd-close
[56.450442] Subtest create-fd-close: SUCCESS (0.000s)
[56.543476] [013/160] (943s left) gem_busy (busy@all-engines)
[56.666326] Starting subtest: busy
[56.667736] Starting dynamic subtest: all-engines
[56.725104] Dynamic subtest all-engines: SUCCESS (0.059s)
[56.726254] Subtest busy: SUCCESS (0.059s)
[57.111627] [014/160] (942s left) gem_close_race (basic-process)
[57.234787] Starting subtest: basic-process
[57.300505] Subtest basic-process: SUCCESS (0.065s)
[57.513627] [015/160] (942s left) gem_close_race (basic-threads)
[57.639151] Starting subtest: basic-threads
[58.911226] Subtest basic-threads: SUCCESS (1.272s)
[59.142598] [016/160] (940s left) gem_ctx_create (basic)
[59.261956] Starting subtest: basic
[59.263235] Subtest basic: SUCCESS (0.000s)
[59.465411] [017/160] (940s left) gem_ctx_create (basic-files)
[59.580607] Starting subtest: basic-files
[61.606724] Subtest basic-files: SUCCESS (2.027s)
[61.828353] [018/160] (938s left) gem_ctx_exec (basic)
[61.930038] Starting subtest: basic
[61.935691] Subtest basic: SUCCESS (0.006s)
[62.051288] [019/160] (938s left) gem_exec_basic (basic)
[62.166513] Starting subtest: basic
[62.167631] Starting dynamic subtest: rcs0-smem
[62.168713] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[62.181268] Starting dynamic subtest: bcs0-smem
[62.182458] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[62.193355] Starting dynamic subtest: vcs0-smem
[62.195056] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[62.205832] Starting dynamic subtest: vecs0-smem
[62.207320] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[62.208756] Subtest basic: SUCCESS (0.006s)
[62.385128] [020/160] (937s left) gem_exec_create (basic)
[62.507232] Starting subtest: basic
[62.508591] Starting dynamic subtest: smem
[64.554719] Dynamic subtest smem: SUCCESS (2.050s)
[64.555824] Subtest basic: SUCCESS (2.050s)
[64.790075] [021/160] (935s left) gem_exec_fence (basic-busy)
[65.059965] Starting subtest: basic-busy
[65.061324] Starting dynamic subtest: rcs0
[65.080085] Dynamic subtest rcs0: SUCCESS (0.028s)
[65.091861] Starting dynamic subtest: bcs0
[65.115312] Dynamic subtest bcs0: SUCCESS (0.034s)
[65.130567] Starting dynamic subtest: vcs0
[65.143151] Dynamic subtest vcs0: SUCCESS (0.028s)
[65.157376] Starting dynamic subtest: vecs0
[65.163292] Dynamic subtest vecs0: SUCCESS (0.020s)
[65.164408] Subtest basic-busy: SUCCESS (0.112s)
[65.773018] [022/160] (934s left) gem_exec_fence (basic-wait)
[66.032954] Starting subtest: basic-wait
[66.034348] Starting dynamic subtest: rcs0
[66.056111] Dynamic subtest rcs0: SUCCESS (0.030s)
[66.071792] Starting dynamic subtest: bcs0
[66.074343] Dynamic subtest bcs0: SUCCESS (0.020s)
[66.085931] Starting dynamic subtest: vcs0
[66.099935] Dynamic subtest vcs0: SUCCESS (0.025s)
[66.112185] Starting dynamic subtest: vecs0
[66.134511] Dynamic subtest vecs0: SUCCESS (0.034s)
[66.136962] Subtest basic-wait: SUCCESS (0.110s)
[66.690677] [023/160] (933s left) gem_exec_fence (basic-await)
[66.960928] Starting subtest: basic-await
[66.962095] Starting dynamic subtest: rcs0
[67.052580] Dynamic subtest rcs0: SUCCESS (0.099s)
[67.079218] Starting dynamic subtest: bcs0
[67.171819] Dynamic subtest bcs0: SUCCESS (0.118s)
[67.199107] Starting dynamic subtest: vcs0
[67.302338] Dynamic subtest vcs0: SUCCESS (0.128s)
[67.330070] Starting dynamic subtest: vecs0
[67.434143] Dynamic subtest vecs0: SUCCESS (0.130s)
[67.436147] Subtest basic-await: SUCCESS (0.479s)
[68.025921] [024/160] (932s left) gem_exec_fence (nb-await)
[68.291491] Starting subtest: nb-await
[68.292670] Starting dynamic subtest: rcs0
[68.350644] Dynamic subtest rcs0: SUCCESS (0.066s)
[68.370158] Starting dynamic subtest: bcs0
[68.423693] Dynamic subtest bcs0: SUCCESS (0.072s)
[68.444032] Starting dynamic subtest: vcs0
[68.496801] Dynamic subtest vcs0: SUCCESS (0.072s)
[68.524291] Starting dynamic subtest: vecs0
[68.571985] Dynamic subtest vecs0: SUCCESS (0.076s)
[68.574147] Subtest nb-await: SUCCESS (0.288s)
[69.126740] [025/160] (931s left) gem_exec_gttfill (basic)
[69.247195] Starting subtest: basic
[75.336269] Subtest basic: SUCCESS (6.081s)
[75.514300] [026/160] (924s left) gem_exec_parallel (engines)
[75.750574] Starting subtest: engines
[75.751783] Starting dynamic subtest: basic
[78.302724] Dynamic subtest basic: SUCCESS (2.530s)
[78.316532] Starting dynamic subtest: contexts
[85.734267] Dynamic subtest contexts: SUCCESS (7.446s)
[85.750573] Starting dynamic subtest: fds
[97.539917] Dynamic subtest fds: SUCCESS (11.814s)
[97.554626] Starting dynamic subtest: userptr
[100.068217] Dynamic subtest userptr: SUCCESS (2.499s)
[100.070196] Subtest engines: SUCCESS (24.290s)
[100.259935] [027/160] (900s left) gem_exec_store (basic)
[100.379421] Starting subtest: basic
[100.438111] Subtest basic: SUCCESS (0.059s)
[100.643439] [028/160] (899s left) gem_flink_basic (bad-flink)
[100.740669] Starting subtest: bad-flink
[100.741854] Subtest bad-flink: SUCCESS (0.000s)
[100.826999] [029/160] (899s left) gem_flink_basic (bad-open)
[100.923381] Starting subtest: bad-open
[100.924471] Subtest bad-open: SUCCESS (0.000s)
[101.026815] [030/160] (899s left) gem_flink_basic (basic)
[101.129579] Starting subtest: basic
[101.130819] Subtest basic: SUCCESS (0.000s)
[101.226827] [031/160] (899s left) gem_flink_basic (double-flink)
[101.324470] Starting subtest: double-flink
[101.325658] Subtest double-flink: SUCCESS (0.000s)
[101.410311] [032/160] (899s left) gem_flink_basic (flink-lifetime)
[101.505762] Starting subtest: flink-lifetime
[101.508502] Subtest flink-lifetime: SUCCESS (0.003s)
[101.609389] [033/160] (898s left) gem_huc_copy (huc-copy)
[101.718022] Starting subtest: huc-copy
[101.720324] Subtest huc-copy: SKIP (0.000s)
[101.827940] [034/160] (898s left) gem_linear_blits (basic)
[102.088234] Starting subtest: basic
[102.105795] Subtest basic: SUCCESS (0.016s)
[102.232243] [035/160] (898s left) gem_mmap (basic)
[102.403721] Starting subtest: basic
[102.409129] Subtest basic: SUCCESS (0.001s)
[102.493823] [036/160] (898s left) gem_mmap_gtt (basic)
[102.596440] Starting subtest: basic
[102.597676] Subtest basic: SUCCESS (0.002s)
[102.704045] [037/160] (897s left) gem_render_linear_blits (basic)
[102.816779] Starting subtest: basic
[102.872197] Subtest basic: SUCCESS (0.055s)
[102.938855] [038/160] (897s left) gem_render_tiled_blits (basic)
[103.046789] Starting subtest: basic
[103.110400] Subtest basic: SUCCESS (0.063s)
[103.171232] [039/160] (897s left) gem_ringfill (basic-all)
[103.450843] Starting subtest: basic-all
[104.714103] Subtest basic-all: SUCCESS (1.253s)
[104.802761] [040/160] (895s left) gem_softpin (allocator-basic)
[104.913852] Starting subtest: allocator-basic
[105.077759] Subtest allocator-basic: SUCCESS (0.164s)
[105.196378] [041/160] (895s left) gem_softpin (allocator-basic-reserve)
[105.302900] Starting subtest: allocator-basic-reserve
[105.475688] Subtest allocator-basic-reserve: SUCCESS (0.164s)
[105.598238] [042/160] (895s left) gem_softpin (safe-alignment)
[105.705752] Starting subtest: safe-alignment
[105.725805] Subtest safe-alignment: SUCCESS (0.020s)
[105.830776] [043/160] (894s left) gem_sync (basic-all)
[105.956786] Starting subtest: basic-all
[108.602558] Subtest basic-all: SUCCESS (2.622s)
[108.786126] [044/160] (892s left) gem_sync (basic-each)
[108.902356] Starting subtest: basic-each
[111.234664] Subtest basic-each: SUCCESS (2.335s)
[111.438501] [045/160] (889s left) gem_tiled_blits (basic)
[111.672337] Starting subtest: basic
[111.704094] Subtest basic: SUCCESS (0.032s)
[111.804333] [046/160] (889s left) gem_tiled_fence_blits (basic)
[112.119152] Starting subtest: basic
[112.149732] Subtest basic: SUCCESS (0.029s)
[112.292590] [047/160] (888s left) gem_tiled_pread_basic
[112.822811] [048/160] (888s left) gem_wait (busy@all-engines)
[112.947439] Starting subtest: busy
[112.948753] Starting dynamic subtest: all-engines
[113.468236] Dynamic subtest all-engines: SUCCESS (0.516s)
[113.469427] Subtest busy: SUCCESS (0.516s)
[113.707276] [049/160] (887s left) gem_wait (wait@all-engines)
[113.827977] Starting subtest: wait
[113.829258] Starting dynamic subtest: all-engines
[114.861531] Dynamic subtest all-engines: SUCCESS (1.034s)
[114.863339] Subtest wait: SUCCESS (1.034s)
[115.108919] [050/160] (885s left) i915_getparams_basic (basic-eu-total)
[115.211523] Starting subtest: basic-eu-total
[115.213614] Subtest basic-eu-total: SUCCESS (0.000s)
[115.308759] [051/160] (885s left) i915_getparams_basic (basic-subslice-total)
[115.402416] Starting subtest: basic-subslice-total
[115.404441] Subtest basic-subslice-total: SUCCESS (0.000s)
[115.509245] [052/160] (885s left) i915_hangman (error-state-basic)
[115.626500] Starting subtest: error-state-basic
[115.639255] Subtest error-state-basic: SUCCESS (0.013s)
[115.722709] [053/160] (885s left) i915_pciid
[115.943562] [054/160] (885s left) kms_addfb_basic (addfb25-4-tiled)
[116.079272] Starting subtest: addfb25-4-tiled
[116.080496] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[116.194457] [055/160] (884s left) kms_addfb_basic (addfb25-bad-modifier)
[116.303272] Starting subtest: addfb25-bad-modifier
[116.304365] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[116.424647] [056/160] (884s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[116.532856] Starting subtest: addfb25-framebuffer-vs-set-tiling
[116.534061] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[116.656049] [057/160] (884s left) kms_addfb_basic (addfb25-modifier-no-flag)
[116.759716] Starting subtest: addfb25-modifier-no-flag
[116.761023] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[116.894351] [058/160] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[116.997483] Starting subtest: addfb25-x-tiled-legacy
[116.998575] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[117.126614] [059/160] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[117.232105] Starting subtest: addfb25-x-tiled-mismatch-legacy
[117.233216] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[117.367228] [060/160] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[117.496671] Starting subtest: addfb25-yf-tiled-legacy
[117.497801] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[117.595854] [061/160] (883s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[117.729626] Starting subtest: addfb25-y-tiled-legacy
[117.730869] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[117.822192] [062/160] (883s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[117.954557] Starting subtest: addfb25-y-tiled-small-legacy
[117.955913] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[118.039317] [063/160] (883s left) kms_addfb_basic (bad-pitch-0)
[118.140935] Starting subtest: bad-pitch-0
[118.142080] Subtest bad-pitch-0: SUCCESS (0.000s)
[118.263390] [064/160] (883s left) kms_addfb_basic (bad-pitch-1024)
[118.368396] Starting subtest: bad-pitch-1024
[118.369474] Subtest bad-pitch-1024: SUCCESS (0.000s)
[118.496169] [065/160] (882s left) kms_addfb_basic (bad-pitch-128)
[118.597961] Starting subtest: bad-pitch-128
[118.599335] Subtest bad-pitch-128: SUCCESS (0.000s)
[118.746201] [066/160] (882s left) kms_addfb_basic (bad-pitch-256)
[118.850090] Starting subtest: bad-pitch-256
[118.851180] Subtest bad-pitch-256: SUCCESS (0.000s)
[118.979893] [067/160] (882s left) kms_addfb_basic (bad-pitch-32)
[119.082756] Starting subtest: bad-pitch-32
[119.084102] Subtest bad-pitch-32: SUCCESS (0.000s)
[119.231415] [068/160] (882s left) kms_addfb_basic (bad-pitch-63)
[119.331919] Starting subtest: bad-pitch-63
[119.333073] Subtest bad-pitch-63: SUCCESS (0.000s)
[119.462601] [069/160] (882s left) kms_addfb_basic (bad-pitch-65536)
[119.561586] Starting subtest: bad-pitch-65536
[119.562763] Subtest bad-pitch-65536: SUCCESS (0.000s)
[119.698123] [070/160] (881s left) kms_addfb_basic (bad-pitch-999)
[119.806577] Starting subtest: bad-pitch-999
[119.807670] Subtest bad-pitch-999: SUCCESS (0.000s)
[119.947842] [071/160] (881s left) kms_addfb_basic (basic)
[120.044398] Starting subtest: basic
[120.045508] Subtest basic: SUCCESS (0.000s)
[120.181280] [072/160] (881s left) kms_addfb_basic (basic-x-tiled-legacy)
[120.285734] Starting subtest: basic-x-tiled-legacy
[120.286813] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[120.431944] [073/160] (881s left) kms_addfb_basic (basic-y-tiled-legacy)
[120.534907] Starting subtest: basic-y-tiled-legacy
[120.536121] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[120.664304] [074/160] (880s left) kms_addfb_basic (bo-too-small)
[120.793148] Starting subtest: bo-too-small
[120.794349] Subtest bo-too-small: SUCCESS (0.001s)
[120.899137] [075/160] (880s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[121.027023] Starting subtest: bo-too-small-due-to-tiling
[121.028203] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[121.133516] [076/160] (880s left) kms_addfb_basic (clobberred-modifier)
[121.230468] Starting subtest: clobberred-modifier
[121.231599] Subtest clobberred-modifier: SUCCESS (0.000s)
[121.366495] [077/160] (880s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[121.469641] Starting subtest: framebuffer-vs-set-tiling
[121.470735] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[121.601085] [078/160] (880s left) kms_addfb_basic (invalid-get-prop)
[121.704755] Starting subtest: invalid-get-prop
[121.705880] Subtest invalid-get-prop: SUCCESS (0.000s)
[121.826393] [079/160] (879s left) kms_addfb_basic (invalid-get-prop-any)
[121.928688] Starting subtest: invalid-get-prop-any
[121.929834] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[122.068610] [080/160] (879s left) kms_addfb_basic (invalid-set-prop)
[122.167676] Starting subtest: invalid-set-prop
[122.168800] Subtest invalid-set-prop: SUCCESS (0.000s)
[122.300506] [081/160] (879s left) kms_addfb_basic (invalid-set-prop-any)
[122.402736] Starting subtest: invalid-set-prop-any
[122.403790] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[122.534293] [082/160] (879s left) kms_addfb_basic (no-handle)
[122.636528] Starting subtest: no-handle
[122.637635] Subtest no-handle: SUCCESS (0.000s)
[122.787469] [083/160] (879s left) kms_addfb_basic (size-max)
[122.914846] Starting subtest: size-max
[122.916070] Subtest size-max: SUCCESS (0.000s)
[123.016638] [084/160] (878s left) kms_addfb_basic (small-bo)
[123.148380] Starting subtest: small-bo
[123.149559] Subtest small-bo: SUCCESS (0.000s)
[123.245580] [085/160] (878s left) kms_addfb_basic (tile-pitch-mismatch)
[123.349827] Starting subtest: tile-pitch-mismatch
[123.351219] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[123.485910] [086/160] (878s left) kms_addfb_basic (too-high)
[123.619460] Starting subtest: too-high
[123.620614] Subtest too-high: SUCCESS (0.001s)
[123.735453] [087/160] (878s left) kms_addfb_basic (too-wide)
[123.861865] Starting subtest: too-wide
[123.863055] Subtest too-wide: SUCCESS (0.000s)
[123.968678] [088/160] (878s left) kms_addfb_basic (unused-handle)
[124.065477] Starting subtest: unused-handle
[124.066686] Subtest unused-handle: SUCCESS (0.000s)
[124.202200] [089/160] (877s left) kms_addfb_basic (unused-modifier)
[124.304670] Starting subtest: unused-modifier
[124.305828] Subtest unused-modifier: SUCCESS (0.000s)
[124.438280] [090/160] (877s left) kms_addfb_basic (unused-offsets)
[124.539624] Starting subtest: unused-offsets
[124.540795] Subtest unused-offsets: SUCCESS (0.000s)
[124.695975] [091/160] (877s left) kms_addfb_basic (unused-pitches)
[124.796881] Starting subtest: unused-pitches
[124.798031] Subtest unused-pitches: SUCCESS (0.000s)
[124.936402] [092/160] (877s left) kms_busy (basic)
[125.067433] Starting subtest: basic
[125.070245] Starting dynamic subtest: flip
[126.072413] Dynamic subtest flip: SUCCESS (1.000s)
[126.087711] Starting dynamic subtest: modeset
[129.937290] Dynamic subtest modeset: SUCCESS (3.867s)
[129.938578] Subtest basic: SUCCESS (4.870s)
[130.912907] [093/160] (871s left) kms_prop_blob (basic)
[131.013424] Starting subtest: basic
[131.014513] Subtest basic: SUCCESS (0.000s)
[131.111862] [094/160] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[131.245061] Starting subtest: basic-busy-flip-before-cursor-atomic
[131.247322] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[131.338296] [095/160] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[131.472516] Starting subtest: basic-busy-flip-before-cursor-legacy
[131.474892] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[131.563064] [096/160] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[131.688530] Starting subtest: basic-flip-after-cursor-atomic
[132.993269] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.305s)
[133.920323] [097/160] (868s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[134.067371] Starting subtest: basic-flip-after-cursor-legacy
[135.370461] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.303s)
[136.286829] [098/160] (866s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[136.415297] Starting subtest: basic-flip-after-cursor-varying-size
[137.680186] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.265s)
[138.656892] [099/160] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[138.789463] Starting subtest: basic-flip-before-cursor-atomic
[140.084482] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.296s)
[141.023248] [100/160] (861s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[141.150264] Starting subtest: basic-flip-before-cursor-legacy
[142.453933] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.304s)
[143.400157] [101/160] (859s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[143.528693] Starting subtest: basic-flip-before-cursor-varying-size
[144.837503] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.307s)
[145.759470] [102/160] (856s left) kms_dsc (dsc-basic)
[145.885246] Starting subtest: dsc-basic
[145.887624] Subtest dsc-basic: SKIP (0.001s)
[145.969123] [103/160] (856s left) kms_flip (basic-flip-vs-dpms)
[146.099622] Starting subtest: basic-flip-vs-dpms
[146.102493] Starting dynamic subtest: A-eDP1
[148.968762] Dynamic subtest A-eDP1: SUCCESS (2.865s)
[148.985214] Starting dynamic subtest: B-eDP1
[151.399759] Dynamic subtest B-eDP1: SUCCESS (2.429s)
[151.415555] Starting dynamic subtest: C-eDP1
[153.831195] Dynamic subtest C-eDP1: SUCCESS (2.432s)
[153.833484] Subtest basic-flip-vs-dpms: SUCCESS (7.734s)
[154.762239] [104/160] (847s left) kms_flip (basic-flip-vs-modeset)
[154.890711] Starting subtest: basic-flip-vs-modeset
[154.893319] Starting dynamic subtest: A-eDP1
[157.777676] Dynamic subtest A-eDP1: SUCCESS (2.884s)
[157.794897] Starting dynamic subtest: B-eDP1
[160.156195] Dynamic subtest B-eDP1: SUCCESS (2.372s)
[160.171213] Starting dynamic subtest: C-eDP1
[162.518081] Dynamic subtest C-eDP1: SUCCESS (2.364s)
[162.519340] Subtest basic-flip-vs-modeset: SUCCESS (7.629s)
[163.487944] [105/160] (839s left) kms_flip (basic-flip-vs-wf_vblank)
[163.622246] Starting subtest: basic-flip-vs-wf_vblank
[163.624832] Starting dynamic subtest: A-eDP1
[165.947466] Dynamic subtest A-eDP1: SUCCESS (2.321s)
[165.965385] Starting dynamic subtest: B-eDP1
[168.233337] Dynamic subtest B-eDP1: SUCCESS (2.283s)
[168.251369] Starting dynamic subtest: C-eDP1
[170.476298] Dynamic subtest C-eDP1: SUCCESS (2.240s)
[170.480540] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.860s)
[171.807563] [106/160] (830s left) kms_flip (basic-plain-flip)
[171.937197] Starting subtest: basic-plain-flip
[171.941362] Starting dynamic subtest: A-eDP1
[173.986841] Dynamic subtest A-eDP1: SUCCESS (2.044s)
[174.006260] Starting dynamic subtest: B-eDP1
[175.952344] Dynamic subtest B-eDP1: SUCCESS (1.962s)
[175.972028] Starting dynamic subtest: C-eDP1
[177.938355] Dynamic subtest C-eDP1: SUCCESS (1.983s)
[177.942935] Subtest basic-plain-flip: SUCCESS (6.006s)
[179.232127] [107/160] (823s left) kms_force_connector_basic (force-connector-state)
[179.335894] Starting subtest: force-connector-state
[179.922919] Subtest force-connector-state: SUCCESS (0.586s)
[180.996827] [108/160] (821s left) kms_force_connector_basic (force-edid)
[181.096532] Starting subtest: force-edid
[181.359499] Subtest force-edid: SUCCESS (0.263s)
[181.493648] [109/160] (821s left) kms_force_connector_basic (force-load-detect)
[181.595410] Starting subtest: force-load-detect
[181.597651] Subtest force-load-detect: SKIP (0.000s)
[181.706907] [110/160] (820s left) kms_force_connector_basic (prune-stale-modes)
[181.812721] Starting subtest: prune-stale-modes
[182.136519] Subtest prune-stale-modes: SUCCESS (0.320s)
[182.258339] [111/160] (820s left) kms_frontbuffer_tracking (basic)
[182.396253] Starting subtest: basic
[186.043834] Subtest basic: SUCCESS (3.647s)
[186.186696] [112/160] (816s left) kms_hdmi_inject (inject-audio)
[186.599805] Starting subtest: inject-audio
[186.844114] Subtest inject-audio: SUCCESS (0.244s)
[187.552315] [113/160] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[187.681476] Starting subtest: compare-crc-sanitycheck-xr24
[187.684334] Starting dynamic subtest: pipe-A-eDP-1
[188.397712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[188.419303] Starting dynamic subtest: pipe-B-eDP-1
[189.814449] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s)
[189.832786] Starting dynamic subtest: pipe-C-eDP-1
[191.208724] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[191.209973] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.527s)
[192.160780] [114/160] (810s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[192.293100] Starting subtest: compare-crc-sanitycheck-nv12
[192.296152] Starting dynamic subtest: pipe-A-eDP-1
[193.242022] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.943s)
[193.262895] Starting dynamic subtest: pipe-B-eDP-1
[194.665272] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s)
[194.684135] Starting dynamic subtest: pipe-C-eDP-1
[196.059234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s)
[196.060523] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.766s)
[197.023938] [115/160] (805s left) kms_pipe_crc_basic (hang-read-crc)
[197.150799] Starting subtest: hang-read-crc
[197.153810] Starting dynamic subtest: pipe-A-eDP-1
[199.586414] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.434s)
[199.604778] Starting dynamic subtest: pipe-B-eDP-1
[202.657021] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.067s)
[202.675778] Starting dynamic subtest: pipe-C-eDP-1
[205.666727] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.006s)
[205.667986] Subtest hang-read-crc: SUCCESS (8.517s)
[206.623929] [116/160] (796s left) kms_pipe_crc_basic (nonblocking-crc)
[206.750139] Starting subtest: nonblocking-crc
[206.751345] Starting dynamic subtest: pipe-A-eDP-1
[207.653251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.901s)
[207.671352] Starting dynamic subtest: pipe-B-eDP-1
[209.271365] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.614s)
[209.289573] Starting dynamic subtest: pipe-C-eDP-1
[210.818921] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.545s)
[210.820184] Subtest nonblocking-crc: SUCCESS (4.071s)
[211.742629] [117/160] (791s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[211.871215] Starting subtest: nonblocking-crc-frame-sequence
[211.872324] Starting dynamic subtest: pipe-A-eDP-1
[212.772181] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.898s)
[212.790409] Starting dynamic subtest: pipe-B-eDP-1
[214.372873] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.598s)
[214.394062] Starting dynamic subtest: pipe-C-eDP-1
[215.940399] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.564s)
[215.941655] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.071s)
[216.863079] [118/160] (786s left) kms_pipe_crc_basic (read-crc)
[217.000646] Starting subtest: read-crc
[217.001945] Starting dynamic subtest: pipe-A-eDP-1
[217.823948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s)
[217.842718] Starting dynamic subtest: pipe-B-eDP-1
[219.379706] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.551s)
[219.398468] Starting dynamic subtest: pipe-C-eDP-1
[220.889937] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.507s)
[220.891168] Subtest read-crc: SUCCESS (3.891s)
[221.858511] [119/160] (781s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[221.985829] Starting subtest: read-crc-frame-sequence
[221.988822] Starting dynamic subtest: pipe-A-eDP-1
[222.819042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.831s)
[222.837892] Starting dynamic subtest: pipe-B-eDP-1
[224.369464] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.546s)
[224.387877] Starting dynamic subtest: pipe-C-eDP-1
[225.850241] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.478s)
[225.851549] Subtest read-crc-frame-sequence: SUCCESS (3.866s)
[226.788743] [120/160] (776s left) kms_pm_backlight (basic-brightness)
[226.923323] Starting subtest: basic-brightness
[227.015615] Starting dynamic subtest: eDP-1
[227.551737] Dynamic subtest eDP-1: SUCCESS (0.535s)
[227.553063] Subtest basic-brightness: SUCCESS (0.627s)
[228.514326] [121/160] (774s left) kms_pm_rpm (basic-pci-d3-state)
[230.361256] Starting subtest: basic-pci-d3-state
[234.808587] Subtest basic-pci-d3-state: SUCCESS (4.447s)
[235.031639] [122/160] (768s left) kms_pm_rpm (basic-rte)
[235.118742] Starting subtest: basic-rte
[241.272861] Subtest basic-rte: SUCCESS (6.153s)
[242.769954] [123/160] (760s left) kms_psr (psr-primary-page-flip)
[242.903261] Starting subtest: psr-primary-page-flip
[242.904462] Starting dynamic subtest: eDP-1
[246.745784] Dynamic subtest eDP-1: SUCCESS (3.839s)
[246.747068] Subtest psr-primary-page-flip: SUCCESS (3.842s)
[247.714529] [124/160] (755s left) kms_psr (psr-cursor-plane-move)
[247.845937] Starting subtest: psr-cursor-plane-move
[247.847177] Starting dynamic subtest: eDP-1
[251.659027] Dynamic subtest eDP-1: SUCCESS (3.809s)
[251.660280] Subtest psr-cursor-plane-move: SUCCESS (3.812s)
[252.578447] [125/160] (750s left) kms_psr (psr-sprite-plane-onoff)
[252.713325] Starting subtest: psr-sprite-plane-onoff
[252.714472] Starting dynamic subtest: eDP-1
[256.674055] Dynamic subtest eDP-1: SUCCESS (3.957s)
[256.675287] Subtest psr-sprite-plane-onoff: SUCCESS (3.960s)
[257.633182] [126/160] (745s left) kms_psr (psr-primary-mmap-gtt)
[257.771373] Starting subtest: psr-primary-mmap-gtt
[257.772524] Starting dynamic subtest: eDP-1
[261.591698] Dynamic subtest eDP-1: SUCCESS (3.819s)
[261.592920] Subtest psr-primary-mmap-gtt: SUCCESS (3.822s)
[262.556180] [127/160] (740s left) kms_setmode (basic-clone-single-crtc)
[262.655219] Starting subtest: basic-clone-single-crtc
[262.658625] Subtest basic-clone-single-crtc: SKIP (0.000s)
[262.756058] [128/160] (740s left) i915_pm_rps (basic-api)
[262.863085] Starting subtest: basic-api
[262.868178] Subtest basic-api: SUCCESS (0.005s)
[262.973950] [129/160] (740s left) prime_self_import (basic-llseek-bad)
[263.064226] Starting subtest: basic-llseek-bad
[263.083463] Subtest basic-llseek-bad: SUCCESS (0.020s)
[263.191923] [130/160] (740s left) prime_self_import (basic-llseek-size)
[263.279562] Starting subtest: basic-llseek-size
[263.297939] Subtest basic-llseek-size: SUCCESS (0.019s)
[263.403424] [131/160] (739s left) prime_self_import (basic-with_fd_dup)
[263.498724] Starting subtest: basic-with_fd_dup
[263.513358] Subtest basic-with_fd_dup: SUCCESS (0.022s)
[263.607203] [132/160] (739s left) prime_self_import (basic-with_one_bo)
[263.696670] Starting subtest: basic-with_one_bo
[263.719433] Subtest basic-with_one_bo: SUCCESS (0.025s)
[263.817759] [133/160] (739s left) prime_self_import (basic-with_one_bo_two_files)
[263.906265] Starting subtest: basic-with_one_bo_two_files
[263.927532] Subtest basic-with_one_bo_two_files: SUCCESS (0.020s)
[264.024449] [134/160] (739s left) prime_self_import (basic-with_two_bos)
[264.112998] Starting subtest: basic-with_two_bos
[264.135738] Subtest basic-with_two_bos: SUCCESS (0.022s)
[264.241679] [135/160] (739s left) prime_vgem (basic-fence-flip)
[264.370915] Starting subtest: basic-fence-flip
[264.903493] Subtest basic-fence-flip: SUCCESS (0.527s)
[265.027425] [136/160] (738s left) prime_vgem (basic-fence-mmap)
[265.156059] Starting subtest: basic-fence-mmap
[265.200699] Subtest basic-fence-mmap: SUCCESS (0.049s)
[265.293199] [137/160] (738s left) prime_vgem (basic-fence-read)
[265.422441] Starting subtest: basic-fence-read
[265.515716] Subtest basic-fence-read: SUCCESS (0.098s)
[265.609131] [138/160] (737s left) prime_vgem (basic-gtt)
[265.745257] Starting subtest: basic-gtt
[265.764152] Subtest basic-gtt: SUCCESS (0.024s)
[265.893986] [139/160] (737s left) prime_vgem (basic-read)
[266.038499] Starting subtest: basic-read
[266.078788] Subtest basic-read: SUCCESS (0.048s)
[266.178284] [140/160] (737s left) prime_vgem (basic-write)
[266.308808] Starting subtest: basic-write
[266.384512] Subtest basic-write: SUCCESS (0.065s)
[266.455564] [141/160] (737s left) vgem_basic (setversion)
[266.550315] Starting subtest: setversion
[266.552507] Subtest setversion: SUCCESS (0.000s)
[266.626494] [142/160] (737s left) vgem_basic (create)
[266.734438] Starting subtest: create
[266.735629] Subtest create: SUCCESS (0.000s)
[266.809852] [143/160] (736s left) vgem_basic (debugfs)
[266.908728] Starting subtest: debugfs
[266.910903] Subtest debugfs: SUCCESS (0.001s)
[266.977495] [144/160] (736s left) vgem_basic (dmabuf-export)
[267.086457] Starting subtest: dmabuf-export
[267.102945] Subtest dmabuf-export: SUCCESS (0.016s)
[267.211784] [145/160] (736s left) vgem_basic (dmabuf-fence)
[267.318563] Starting subtest: dmabuf-fence
[267.319724] Subtest dmabuf-fence: SUCCESS (0.001s)
[267.394773] [146/160] (736s left) vgem_basic (dmabuf-fence-before)
[267.501747] Starting subtest: dmabuf-fence-before
[267.504088] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[267.577078] [147/160] (736s left) vgem_basic (dmabuf-mmap)
[267.685513] Starting subtest: dmabuf-mmap
[267.720341] Subtest dmabuf-mmap: SUCCESS (0.025s)
[267.774130] [148/160] (736s left) vgem_basic (mmap)
[267.868210] Starting subtest: mmap
[267.885387] Subtest mmap: SUCCESS (0.017s)
[267.970905] [149/160] (735s left) vgem_basic (second-client)
[268.068795] Starting subtest: second-client
[268.104595] Subtest second-client: SUCCESS (0.034s)
[268.181899] [150/160] (735s left) vgem_basic (sysfs)
[268.285805] Starting subtest: sysfs
[268.287069] Subtest sysfs: SUCCESS (0.001s)
[268.362053] [151/160] (735s left) core_hotunplug (unbind-rebind)
[268.519446] Starting subtest: unbind-rebind
[274.594448] Subtest unbind-rebind: SUCCESS (6.075s)
[274.630792] [152/160] (729s left) vgem_basic (unload)
[274.725492] Starting subtest: unload
[303.792127] Subtest unload: SUCCESS (29.031s)
[303.903663] [153/160] (700s left) i915_module_load (reload)
[303.997217] Starting subtest: reload
[308.942582] Subtest reload: SUCCESS (4.945s)
[308.973532] [154/160] (695s left) gem_lmem_swapping (basic)
[309.083904] Subtest basic: SKIP (0.000s)
[309.126778] [155/160] (694s left) gem_lmem_swapping (parallel-random-engines)
[309.224321] Subtest parallel-random-engines: SKIP (0.000s)
[309.277340] [156/160] (694s left) gem_lmem_swapping (random-engines)
[309.377040] Subtest random-engines: SKIP (0.000s)
[309.427753] [157/160] (694s left) gem_lmem_swapping (verify-random)
[309.526484] Subtest verify-random: SKIP (0.000s)
[309.578261] [158/160] (694s left) i915_pm_rpm (module-reload)
[322.069574] Starting subtest: module-reload
[354.533053] Subtest module-reload: SUCCESS (32.457s)
[354.557995] [159/160] (649s left) i915_selftest (live)
[354.657660] Starting subtest: live
[354.658884] Starting dynamic subtest: sanitycheck
[358.136419] Dynamic subtest sanitycheck: SUCCESS (3.469s)
[358.146975] Starting dynamic subtest: uncore
[361.595096] Dynamic subtest uncore: SUCCESS (3.455s)
[361.605752] Starting dynamic subtest: workarounds
[365.312539] Dynamic subtest workarounds: SUCCESS (3.714s)
[365.323152] Starting dynamic subtest: gt_engines
[369.197958] Dynamic subtest gt_engines: SUCCESS (3.881s)
[369.209811] Starting dynamic subtest: gt_timelines
[384.684539] Dynamic subtest gt_timelines: SUCCESS (15.483s)
[384.695182] Starting dynamic subtest: gt_contexts
[388.202389] Dynamic subtest gt_contexts: SUCCESS (3.514s)
[388.213120] Starting dynamic subtest: gt_lrc
[393.656931] Dynamic subtest gt_lrc: SUCCESS (5.451s)
[393.667598] Starting dynamic subtest: gt_mocs
[397.260778] Dynamic subtest gt_mocs: SUCCESS (3.600s)
[397.271568] Starting dynamic subtest: gt_pm
[403.960509] Dynamic subtest gt_pm: SUCCESS (6.696s)
[403.971255] Starting dynamic subtest: gt_heartbeat
[407.473572] Dynamic subtest gt_heartbeat: SUCCESS (3.510s)
[407.484252] Starting dynamic subtest: gt_tlb
[412.043554] Dynamic subtest gt_tlb: SUCCESS (4.568s)
[412.054926] Starting dynamic subtest: requests
[421.319715] Dynamic subtest requests: SUCCESS (9.271s)
[421.330874] Starting dynamic subtest: migrate
[427.235471] Dynamic subtest migrate: SUCCESS (5.912s)
[427.246164] Starting dynamic subtest: active
[430.739995] Dynamic subtest active: SUCCESS (3.501s)
[430.750881] Starting dynamic subtest: objects
[435.453722] Dynamic subtest objects: SUCCESS (4.710s)
[435.464730] Starting dynamic subtest: mman
[444.397522] Dynamic subtest mman: SUCCESS (8.940s)
[444.408313] Starting dynamic subtest: dmabuf
[447.884648] Dynamic subtest dmabuf: SUCCESS (3.484s)
[447.895757] Starting dynamic subtest: vma
[451.321429] Dynamic subtest vma: SUCCESS (3.433s)
[451.332159] Starting dynamic subtest: coherency
[457.706468] Dynamic subtest coherency: SUCCESS (6.382s)
[457.717493] Starting dynamic subtest: gtt
[468.466608] Dynamic subtest gtt: SUCCESS (10.756s)
[468.477399] Starting dynamic subtest: gem
[472.082482] Dynamic subtest gem: SUCCESS (3.613s)
[472.093416] Starting dynamic subtest: evict
[477.266332] Dynamic subtest evict: SUCCESS (5.180s)
[477.278580] Starting dynamic subtest: hugepages
[486.633701] Dynamic subtest hugepages: SUCCESS (9.364s)
[486.645481] Starting dynamic subtest: gem_contexts
[505.085160] Dynamic subtest gem_contexts: SUCCESS (18.422s)
[505.100761] Starting dynamic subtest: client
[508.515405] Dynamic subtest client: SUCCESS (3.452s)
[508.526582] Starting dynamic subtest: gem_migrate
[512.003695] Dynamic subtest gem_migrate: SUCCESS (3.485s)
[512.015154] Starting dynamic subtest: reset
[518.930411] Dynamic subtest reset: SUCCESS (6.923s)
[518.941727] Starting dynamic subtest: memory_region
[522.422252] Dynamic subtest memory_region: SUCCESS (3.489s)
[522.434198] Starting dynamic subtest: hangcheck
[548.445772] Dynamic subtest hangcheck: SUCCESS (26.021s)
[548.457187] Starting dynamic subtest: execlists
[560.590318] Dynamic subtest execlists: SUCCESS (12.141s)
[560.601910] Starting dynamic subtest: ring_submission
[564.028482] Dynamic subtest ring_submission: SUCCESS (3.434s)
[564.039812] Starting dynamic subtest: perf
[567.623886] Dynamic subtest perf: SUCCESS (3.592s)
[567.635917] Starting dynamic subtest: slpc
[571.079083] Dynamic subtest slpc: SUCCESS (3.452s)
[571.090423] Starting dynamic subtest: guc
[574.546716] Dynamic subtest guc: SUCCESS (3.465s)
[574.558655] Starting dynamic subtest: guc_multi_lrc
[578.055608] Dynamic subtest guc_multi_lrc: SUCCESS (3.505s)
[578.066981] Starting dynamic subtest: guc_hang
[581.498518] Dynamic subtest guc_hang: SUCCESS (3.440s)
[581.509891] Starting dynamic subtest: late_gt_pm
[585.019440] Dynamic subtest late_gt_pm: SUCCESS (3.518s)
[585.020698] Subtest live: SUCCESS (230.355s)
[585.045715] [160/160] (419s left) dmabuf (all-tests)
[585.140634] Starting subtest: all-tests
[585.142560] Starting dynamic subtest: sanitycheck
[585.209707] Dynamic subtest sanitycheck: SUCCESS (0.067s)
[585.229396] Starting dynamic subtest: dma_fence
[585.395087] Dynamic subtest dma_fence: SUCCESS (0.181s)
[585.414125] Starting dynamic subtest: dma_fence_chain
[603.257932] Dynamic subtest dma_fence_chain: SUCCESS (17.851s)
[603.271491] Starting dynamic subtest: dma_fence_unwrap
[603.323631] Dynamic subtest dma_fence_unwrap: SUCCESS (0.070s)
[603.343379] Starting dynamic subtest: dma_resv
[603.416756] Dynamic subtest dma_resv: SUCCESS (0.089s)
[603.419297] Subtest all-tests: SUCCESS (18.277s)
[603.448853] Closing watchdogs
Done.