[48.286455] Initializing watchdogs
[48.286581]   /dev/watchdog0
[48.296851] [001/165] (960s left) i915_module_load (load)
[48.389184] Starting subtest: load
[50.340623] Subtest load: SUCCESS (1.952s)
[50.400777] [002/165] (958s left) core_auth (basic-auth)
[50.569566] Starting subtest: basic-auth
[50.571901] Subtest basic-auth: SUCCESS (0.004s)
[50.647866] [003/165] (958s left) debugfs_test (read_all_entries)
[50.743033] Starting subtest: read_all_entries
[50.792511] Subtest read_all_entries: SUCCESS (0.053s)
[51.798430] [004/165] (957s left) debugfs_test (basic-hwmon)
[51.886758] Starting subtest: basic-hwmon
[51.889957] Subtest basic-hwmon: SKIP (0.000s)
[52.914633] [005/165] (955s left) fbdev (eof)
[53.020333] Starting subtest: eof
[53.022230] Subtest eof: SUCCESS (0.001s)
[53.080416] [006/165] (955s left) fbdev (info)
[53.167891] Starting subtest: info
[53.169894] Subtest info: SUCCESS (0.000s)
[53.244998] [007/165] (955s left) fbdev (nullptr)
[53.335538] Starting subtest: nullptr
[53.337342] Subtest nullptr: SUCCESS (0.000s)
[53.395114] [008/165] (955s left) fbdev (read)
[53.484558] Starting subtest: read
[53.706278] Subtest read: SUCCESS (0.220s)
[53.758839] [009/165] (955s left) fbdev (write)
[53.869839] Starting subtest: write
[53.996820] Subtest write: SUCCESS (0.129s)
[54.057969] [010/165] (954s left) gem_basic (bad-close)
[54.152591] Starting subtest: bad-close
[54.155849] Subtest bad-close: SUCCESS (0.000s)
[54.226789] [011/165] (954s left) gem_basic (create-close)
[54.318073] Starting subtest: create-close
[54.321267] Subtest create-close: SUCCESS (0.000s)
[54.390896] [012/165] (954s left) gem_basic (create-fd-close)
[54.479562] Starting subtest: create-fd-close
[54.483266] Subtest create-fd-close: SUCCESS (0.001s)
[54.558801] [013/165] (954s left) gem_busy (busy@all-engines)
[54.661506] Starting subtest: busy
[54.663205] Starting dynamic subtest: all-engines
[54.744700] Dynamic subtest all-engines: SUCCESS (0.085s)
[54.746460] Subtest busy: SUCCESS (0.086s)
[55.074621] [014/165] (954s left) gem_close_race (basic-process)
[55.181214] Starting subtest: basic-process
[55.229378] Subtest basic-process: SUCCESS (0.048s)
[55.406342] [015/165] (953s left) gem_close_race (basic-threads)
[55.509286] Starting subtest: basic-threads
[56.644922] Subtest basic-threads: SUCCESS (1.137s)
[56.822713] [016/165] (952s left) gem_ctx_create (basic)
[56.921476] Starting subtest: basic
[56.923227] Subtest basic: SUCCESS (0.000s)
[57.104413] [017/165] (952s left) gem_ctx_create (basic-files)
[57.202378] Starting subtest: basic-files
[59.223828] Subtest basic-files: SUCCESS (2.023s)
[59.449933] [018/165] (949s left) gem_ctx_exec (basic)
[59.566925] Starting subtest: basic
[59.569937] Subtest basic: SUCCESS (0.001s)
[59.647917] [019/165] (949s left) gem_exec_basic (basic)
[59.744542] Starting subtest: basic
[59.746258] Starting dynamic subtest: rcs0-smem
[59.747880] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[59.756187] Starting dynamic subtest: vcs0-smem
[59.758073] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[59.760027] Subtest basic: SUCCESS (0.001s)
[59.931385] [020/165] (949s left) gem_exec_create (basic)
[60.028391] Starting subtest: basic
[60.030335] Starting dynamic subtest: smem
[62.067685] Dynamic subtest smem: SUCCESS (2.037s)
[62.069596] Subtest basic: SUCCESS (2.038s)
[62.242731] [021/165] (947s left) gem_exec_fence (basic-busy)
[62.476045] Starting subtest: basic-busy
[62.477797] Starting dynamic subtest: rcs0
[62.515088] Dynamic subtest rcs0: SUCCESS (0.040s)
[62.525472] Starting dynamic subtest: vcs0
[62.528856] Dynamic subtest vcs0: SUCCESS (0.013s)
[62.530453] Subtest basic-busy: SUCCESS (0.053s)
[63.027334] [022/165] (946s left) gem_exec_fence (basic-wait)
[63.255543] Starting subtest: basic-wait
[63.257234] Starting dynamic subtest: rcs0
[63.266214] Dynamic subtest rcs0: SUCCESS (0.011s)
[63.276815] Starting dynamic subtest: vcs0
[63.278732] Dynamic subtest vcs0: SUCCESS (0.011s)
[63.280736] Subtest basic-wait: SUCCESS (0.022s)
[63.742062] [023/165] (945s left) gem_exec_fence (basic-await)
[63.968913] Starting subtest: basic-await
[63.970712] Starting dynamic subtest: rcs0
[64.040913] Dynamic subtest rcs0: SUCCESS (0.073s)
[64.055034] Starting dynamic subtest: vcs0
[64.110922] Dynamic subtest vcs0: SUCCESS (0.072s)
[64.112816] Subtest basic-await: SUCCESS (0.145s)
[64.573969] [024/165] (944s left) gem_exec_fence (nb-await)
[64.801922] Starting subtest: nb-await
[64.803901] Starting dynamic subtest: rcs0
[64.855590] Dynamic subtest rcs0: SUCCESS (0.054s)
[64.866194] Starting dynamic subtest: vcs0
[64.907139] Dynamic subtest vcs0: SUCCESS (0.053s)
[64.909031] Subtest nb-await: SUCCESS (0.108s)
[65.370387] [025/165] (943s left) gem_exec_gttfill (basic)
[65.472111] Starting subtest: basic
[73.118132] Subtest basic: SUCCESS (7.645s)
[73.303440] [026/165] (936s left) gem_exec_parallel (engines)
[73.499553] Starting subtest: engines
[73.501490] Starting dynamic subtest: basic
[75.750680] Dynamic subtest basic: SUCCESS (2.253s)
[75.760419] Starting dynamic subtest: contexts
[77.707968] Dynamic subtest contexts: SUCCESS (1.955s)
[77.720023] Starting dynamic subtest: fds
[77.723334] Dynamic subtest fds: SKIP (0.001s)
[77.733131] Starting dynamic subtest: userptr
[79.437892] Dynamic subtest userptr: SUCCESS (1.729s)
[79.439954] Subtest engines: SUCCESS (5.940s)
[79.628383] [027/165] (929s left) gem_exec_store (basic)
[79.729257] Starting subtest: basic
[79.757609] Subtest basic: SUCCESS (0.029s)
[79.941714] [028/165] (929s left) gem_flink_basic (bad-flink)
[80.030829] Starting subtest: bad-flink
[80.032496] Subtest bad-flink: SUCCESS (0.000s)
[80.092293] [029/165] (929s left) gem_flink_basic (bad-open)
[80.182446] Starting subtest: bad-open
[80.184089] Subtest bad-open: SUCCESS (0.000s)
[80.262679] [030/165] (929s left) gem_flink_basic (basic)
[80.349719] Starting subtest: basic
[80.351496] Subtest basic: SUCCESS (0.000s)
[80.425868] [031/165] (929s left) gem_flink_basic (double-flink)
[80.514801] Starting subtest: double-flink
[80.516522] Subtest double-flink: SUCCESS (0.000s)
[80.591236] [032/165] (928s left) gem_flink_basic (flink-lifetime)
[80.677638] Starting subtest: flink-lifetime
[80.679283] Subtest flink-lifetime: SUCCESS (0.001s)
[80.757472] [033/165] (928s left) gem_huc_copy (huc-copy)
[80.846594] Subtest huc-copy: SKIP (0.000s)
[80.877313] [034/165] (928s left) gem_linear_blits (basic)
[81.076554] Starting subtest: basic
[81.091095] Subtest basic: SUCCESS (0.013s)
[81.206572] [035/165] (928s left) gem_mmap (basic)
[81.397299] Starting subtest: basic
[81.406643] Subtest basic: SUCCESS (0.000s)
[81.472051] [036/165] (928s left) gem_mmap_gtt (basic)
[81.561322] Starting subtest: basic
[81.562982] Subtest basic: SUCCESS (0.001s)
[81.643661] [037/165] (928s left) gem_render_linear_blits (basic)
[81.734825] Starting subtest: basic
[81.769774] Subtest basic: SUCCESS (0.036s)
[81.807893] [038/165] (927s left) gem_render_tiled_blits (basic)
[81.897850] Starting subtest: basic
[81.935553] Subtest basic: SUCCESS (0.037s)
[81.990822] [039/165] (927s left) gem_ringfill (basic-all)
[82.125105] Starting subtest: basic-all
[83.238580] Subtest basic-all: SUCCESS (1.112s)
[83.318739] [040/165] (926s left) gem_softpin (allocator-basic)
[83.410440] Subtest allocator-basic: SKIP (0.000s)
[83.486034] [041/165] (926s left) gem_softpin (allocator-basic-reserve)
[83.577673] Subtest allocator-basic-reserve: SKIP (0.000s)
[83.650771] [042/165] (926s left) gem_softpin (safe-alignment)
[83.743654] Starting subtest: safe-alignment
[83.748139] Subtest safe-alignment: SUCCESS (0.009s)
[83.835665] [043/165] (925s left) gem_sync (basic-all)
[83.941930] Starting subtest: basic-all
[86.096422] Subtest basic-all: SUCCESS (2.158s)
[86.281383] [044/165] (923s left) gem_sync (basic-each)
[86.382371] Starting subtest: basic-each
[88.461798] Subtest basic-each: SUCCESS (2.080s)
[88.641120] [045/165] (921s left) gem_tiled_blits (basic)
[88.839050] Starting subtest: basic
[88.862925] Subtest basic: SUCCESS (0.022s)
[88.973382] [046/165] (920s left) gem_tiled_fence_blits (basic)
[89.282387] Starting subtest: basic
[89.296184] Subtest basic: SUCCESS (0.011s)
[89.406178] [047/165] (920s left) gem_tiled_pread_basic
[89.840637] [048/165] (920s left) gem_wait (busy@all-engines)
[89.948990] Starting subtest: busy
[89.950689] Starting dynamic subtest: all-engines
[90.459377] Dynamic subtest all-engines: SUCCESS (0.511s)
[90.461104] Subtest busy: SUCCESS (0.511s)
[90.670087] [049/165] (919s left) gem_wait (wait@all-engines)
[90.778079] Starting subtest: wait
[90.779907] Starting dynamic subtest: all-engines
[91.791648] Dynamic subtest all-engines: SUCCESS (1.015s)
[91.793319] Subtest wait: SUCCESS (1.015s)
[92.002961] [050/165] (917s left) i915_getparams_basic (basic-eu-total)
[92.092532] Starting subtest: basic-eu-total
[92.095791] Subtest basic-eu-total: SUCCESS (0.000s)
[92.166730] [051/165] (917s left) i915_getparams_basic (basic-subslice-total)
[92.250854] Starting subtest: basic-subslice-total
[92.255032] Subtest basic-subslice-total: SUCCESS (0.000s)
[92.318386] [052/165] (917s left) i915_hangman (error-state-basic)
[92.411797] Starting subtest: error-state-basic
[92.422164] Subtest error-state-basic: SUCCESS (0.008s)
[92.468627] [053/165] (917s left) i915_pciid
[92.634409] [054/165] (917s left) kms_addfb_basic (addfb25-4-tiled)
[93.272785] Starting subtest: addfb25-4-tiled
[93.274773] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[93.763146] [055/165] (916s left) kms_addfb_basic (addfb25-bad-modifier)
[93.854665] Starting subtest: addfb25-bad-modifier
[93.856483] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[94.864060] [056/165] (915s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[94.954302] Starting subtest: addfb25-framebuffer-vs-set-tiling
[94.956400] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[95.979377] [057/165] (914s left) kms_addfb_basic (addfb25-modifier-no-flag)
[96.072840] Starting subtest: addfb25-modifier-no-flag
[96.074593] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[97.075367] [058/165] (913s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[97.163998] Starting subtest: addfb25-x-tiled-legacy
[97.165706] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[98.174246] [059/165] (912s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[98.263100] Starting subtest: addfb25-x-tiled-mismatch-legacy
[98.266819] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[99.288257] [060/165] (910s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[99.906271] Starting subtest: addfb25-yf-tiled-legacy
[99.908150] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[100.386089] [061/165] (909s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[100.997477] Starting subtest: addfb25-y-tiled-legacy
[100.999323] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[101.480833] [062/165] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[102.094653] Starting subtest: addfb25-y-tiled-small-legacy
[102.098373] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[102.581698] [063/165] (907s left) kms_addfb_basic (bad-pitch-0)
[102.673426] Starting subtest: bad-pitch-0
[102.675310] Subtest bad-pitch-0: SUCCESS (0.000s)
[103.696205] [064/165] (906s left) kms_addfb_basic (bad-pitch-1024)
[103.785592] Starting subtest: bad-pitch-1024
[103.787249] Subtest bad-pitch-1024: SUCCESS (0.000s)
[104.789435] [065/165] (905s left) kms_addfb_basic (bad-pitch-128)
[104.876612] Starting subtest: bad-pitch-128
[104.878282] Subtest bad-pitch-128: SUCCESS (0.000s)
[105.890733] [066/165] (904s left) kms_addfb_basic (bad-pitch-256)
[105.982679] Starting subtest: bad-pitch-256
[105.984943] Subtest bad-pitch-256: SUCCESS (0.000s)
[106.988782] [067/165] (903s left) kms_addfb_basic (bad-pitch-32)
[107.080767] Starting subtest: bad-pitch-32
[107.082587] Subtest bad-pitch-32: SUCCESS (0.000s)
[108.087185] [068/165] (902s left) kms_addfb_basic (bad-pitch-63)
[108.177306] Starting subtest: bad-pitch-63
[108.178931] Subtest bad-pitch-63: SUCCESS (0.000s)
[109.185074] [069/165] (901s left) kms_addfb_basic (bad-pitch-65536)
[109.274546] Starting subtest: bad-pitch-65536
[109.276198] Subtest bad-pitch-65536: SUCCESS (0.000s)
[110.280505] [070/165] (900s left) kms_addfb_basic (bad-pitch-999)
[110.370280] Starting subtest: bad-pitch-999
[110.371929] Subtest bad-pitch-999: SUCCESS (0.000s)
[111.378769] [071/165] (899s left) kms_addfb_basic (basic)
[111.469429] Starting subtest: basic
[111.471299] Subtest basic: SUCCESS (0.000s)
[112.478258] [072/165] (898s left) kms_addfb_basic (basic-x-tiled-legacy)
[112.587470] Starting subtest: basic-x-tiled-legacy
[112.589281] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[113.592307] [073/165] (896s left) kms_addfb_basic (basic-y-tiled-legacy)
[113.684507] Starting subtest: basic-y-tiled-legacy
[113.686299] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[114.704114] [074/165] (895s left) kms_addfb_basic (bo-too-small)
[115.323033] Starting subtest: bo-too-small
[115.324977] Subtest bo-too-small: SUCCESS (0.000s)
[115.789241] [075/165] (894s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[116.405097] Starting subtest: bo-too-small-due-to-tiling
[116.406829] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[116.903315] [076/165] (893s left) kms_addfb_basic (clobberred-modifier)
[116.996750] Starting subtest: clobberred-modifier
[116.998623] Subtest clobberred-modifier: SUCCESS (0.000s)
[118.001529] [077/165] (892s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[118.090763] Starting subtest: framebuffer-vs-set-tiling
[118.092485] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[119.129357] [078/165] (891s left) kms_addfb_basic (invalid-get-prop)
[119.223939] Starting subtest: invalid-get-prop
[119.225928] Subtest invalid-get-prop: SUCCESS (0.000s)
[120.246214] [079/165] (890s left) kms_addfb_basic (invalid-get-prop-any)
[120.333755] Starting subtest: invalid-get-prop-any
[120.336505] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[121.343982] [080/165] (889s left) kms_addfb_basic (invalid-set-prop)
[121.435105] Starting subtest: invalid-set-prop
[121.436862] Subtest invalid-set-prop: SUCCESS (0.000s)
[122.475330] [081/165] (888s left) kms_addfb_basic (invalid-set-prop-any)
[122.565093] Starting subtest: invalid-set-prop-any
[122.566861] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[123.589595] [082/165] (887s left) kms_addfb_basic (no-handle)
[123.680543] Starting subtest: no-handle
[123.682181] Subtest no-handle: SUCCESS (0.000s)
[124.718425] [083/165] (886s left) kms_addfb_basic (size-max)
[125.331054] Starting subtest: size-max
[125.332861] Subtest size-max: SUCCESS (0.000s)
[125.835602] [084/165] (884s left) kms_addfb_basic (small-bo)
[126.467924] Starting subtest: small-bo
[126.469863] Subtest small-bo: SUCCESS (0.000s)
[126.966527] [085/165] (883s left) kms_addfb_basic (tile-pitch-mismatch)
[127.056616] Starting subtest: tile-pitch-mismatch
[127.058236] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[128.080382] [086/165] (882s left) kms_addfb_basic (too-high)
[128.697421] Starting subtest: too-high
[128.699161] Subtest too-high: SUCCESS (0.002s)
[129.195699] [087/165] (881s left) kms_addfb_basic (too-wide)
[129.812967] Starting subtest: too-wide
[129.814815] Subtest too-wide: SUCCESS (0.000s)
[130.305976] [088/165] (880s left) kms_addfb_basic (unused-handle)
[130.394330] Starting subtest: unused-handle
[130.395934] Subtest unused-handle: SUCCESS (0.000s)
[131.441269] [089/165] (879s left) kms_addfb_basic (unused-modifier)
[131.529530] Starting subtest: unused-modifier
[131.532561] Subtest unused-modifier: SUCCESS (0.000s)
[132.555277] [090/165] (878s left) kms_addfb_basic (unused-offsets)
[132.668669] Starting subtest: unused-offsets
[132.670976] Subtest unused-offsets: SUCCESS (0.000s)
[133.686508] [091/165] (877s left) kms_addfb_basic (unused-pitches)
[133.778178] Starting subtest: unused-pitches
[133.779908] Subtest unused-pitches: SUCCESS (0.000s)
[134.800433] [092/165] (876s left) kms_busy (basic)
[135.424328] Starting subtest: basic
[135.426295] Starting dynamic subtest: flip
[136.193526] Dynamic subtest flip: SUCCESS (0.765s)
[136.204467] Starting dynamic subtest: modeset
[136.895126] Dynamic subtest modeset: SUCCESS (0.699s)
[136.897491] Subtest basic: SUCCESS (1.468s)
[137.451378] [093/165] (873s left) kms_prop_blob (basic)
[137.569547] Starting subtest: basic
[137.571650] Subtest basic: SUCCESS (0.000s)
[137.629521] [094/165] (873s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[138.259537] Starting subtest: basic-busy-flip-before-cursor-atomic
[139.288359] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.030s)
[139.858344] [095/165] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[140.491924] Starting subtest: basic-busy-flip-before-cursor-legacy
[141.517038] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.025s)
[142.068634] [096/165] (869s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[142.691648] Starting subtest: basic-flip-after-cursor-atomic
[143.726034] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.029s)
[144.301429] [097/165] (866s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[144.952741] Starting subtest: basic-flip-after-cursor-legacy
[145.925841] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.008s)
[146.476851] [098/165] (864s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[147.111952] Starting subtest: basic-flip-after-cursor-varying-size
[148.135422] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.025s)
[148.700938] [099/165] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[149.340691] Starting subtest: basic-flip-before-cursor-atomic
[150.362082] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.020s)
[150.916294] [100/165] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[151.535583] Starting subtest: basic-flip-before-cursor-legacy
[152.559152] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.023s)
[153.145293] [101/165] (858s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[153.770361] Starting subtest: basic-flip-before-cursor-varying-size
[154.785066] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.011s)
[155.363418] [102/165] (855s left) kms_dsc (dsc-basic)
[155.997039] Subtest dsc-basic: SKIP (0.000s)
[156.275872] [103/165] (855s left) kms_flip (basic-flip-vs-dpms)
[156.764858] Starting subtest: basic-flip-vs-dpms
[156.766725] Starting dynamic subtest: A-VGA1
[157.524287] Dynamic subtest A-VGA1: SUCCESS (0.755s)
[157.537682] Starting dynamic subtest: B-VGA1
[158.156911] Dynamic subtest B-VGA1: SUCCESS (0.632s)
[158.174720] Starting dynamic subtest: A-HDMI-A1
[158.858058] Dynamic subtest A-HDMI-A1: SUCCESS (0.696s)
[158.873112] Starting dynamic subtest: B-HDMI-A1
[159.572051] Dynamic subtest B-HDMI-A1: SUCCESS (0.698s)
[159.574818] Subtest basic-flip-vs-dpms: SUCCESS (2.795s)
[160.155384] [104/165] (851s left) kms_flip (basic-flip-vs-modeset)
[160.636140] Starting subtest: basic-flip-vs-modeset
[160.637864] Starting dynamic subtest: A-VGA1
[161.483297] Dynamic subtest A-VGA1: SUCCESS (0.844s)
[161.497688] Starting dynamic subtest: B-VGA1
[162.192952] Dynamic subtest B-VGA1: SUCCESS (0.705s)
[162.204220] Starting dynamic subtest: A-HDMI-A1
[162.945192] Dynamic subtest A-HDMI-A1: SUCCESS (0.741s)
[162.959397] Starting dynamic subtest: B-HDMI-A1
[163.668662] Dynamic subtest B-HDMI-A1: SUCCESS (0.729s)
[163.673696] Subtest basic-flip-vs-modeset: SUCCESS (3.034s)
[164.259639] [105/165] (847s left) kms_flip (basic-flip-vs-wf_vblank)
[164.740805] Starting subtest: basic-flip-vs-wf_vblank
[164.742758] Starting dynamic subtest: A-VGA1
[165.800075] Dynamic subtest A-VGA1: SUCCESS (1.055s)
[165.810500] Starting dynamic subtest: B-VGA1
[166.774129] Dynamic subtest B-VGA1: SUCCESS (0.972s)
[166.786784] Starting dynamic subtest: A-HDMI-A1
[167.931672] Dynamic subtest A-HDMI-A1: SUCCESS (1.155s)
[167.943552] Starting dynamic subtest: B-HDMI-A1
[169.164895] Dynamic subtest B-HDMI-A1: SUCCESS (1.232s)
[169.166838] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.428s)
[169.817134] [106/165] (841s left) kms_flip (basic-plain-flip)
[170.293261] Starting subtest: basic-plain-flip
[170.295093] Starting dynamic subtest: A-VGA1
[171.067483] Dynamic subtest A-VGA1: SUCCESS (0.771s)
[171.083588] Starting dynamic subtest: B-VGA1
[171.753090] Dynamic subtest B-VGA1: SUCCESS (0.681s)
[171.767074] Starting dynamic subtest: A-HDMI-A1
[172.514785] Dynamic subtest A-HDMI-A1: SUCCESS (0.759s)
[172.528281] Starting dynamic subtest: B-HDMI-A1
[173.301807] Dynamic subtest B-HDMI-A1: SUCCESS (0.785s)
[173.304889] Subtest basic-plain-flip: SUCCESS (3.012s)
[173.970158] [107/165] (837s left) kms_force_connector_basic (force-connector-state)
[174.119652] Starting subtest: force-connector-state
[174.940390] Subtest force-connector-state: SUCCESS (0.821s)
[175.660378] [108/165] (835s left) kms_force_connector_basic (force-edid)
[175.802558] Starting subtest: force-edid
[176.114411] Subtest force-edid: SUCCESS (0.311s)
[176.772737] [109/165] (834s left) kms_force_connector_basic (force-load-detect)
[176.921712] Starting subtest: force-load-detect
[177.119218] Subtest force-load-detect: SUCCESS (0.198s)
[177.649737] [110/165] (833s left) kms_force_connector_basic (prune-stale-modes)
[177.805204] Starting subtest: prune-stale-modes
[178.108855] Subtest prune-stale-modes: SUCCESS (0.308s)
[178.762516] [111/165] (832s left) kms_frontbuffer_tracking (basic)
[179.411499] Starting subtest: basic
[179.685748] Subtest basic: SKIP (0.275s)
[180.329127] [112/165] (831s left) kms_hdmi_inject (inject-audio)
[180.659769] Starting subtest: inject-audio
[180.664802] Subtest inject-audio: SKIP (0.000s)
[180.910715] [113/165] (830s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[181.695583] Starting subtest: compare-crc-sanitycheck-xr24
[181.697265] Starting dynamic subtest: pipe-A-HDMI-A-1
[182.080056] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.374s)
[182.093984] Starting dynamic subtest: pipe-B-HDMI-A-1
[182.465090] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.392s)
[182.466950] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.773s)
[183.058677] [114/165] (828s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[183.687073] Starting subtest: compare-crc-sanitycheck-nv12
[183.689072] Starting dynamic subtest: pipe-A-HDMI-A-1
[183.693658] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[183.703998] Starting dynamic subtest: pipe-B-HDMI-A-1
[183.709647] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[183.715270] Subtest compare-crc-sanitycheck-nv12: SKIP (0.007s)
[184.191267] [115/165] (827s left) kms_pipe_crc_basic (hang-read-crc)
[184.832990] Starting subtest: hang-read-crc
[184.834762] Starting dynamic subtest: pipe-A-HDMI-A-1
[185.818570] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.985s)
[185.829261] Starting dynamic subtest: pipe-B-HDMI-A-1
[186.858199] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.034s)
[186.860310] Subtest hang-read-crc: SUCCESS (2.028s)
[187.430331] [116/165] (824s left) kms_pipe_crc_basic (nonblocking-crc)
[188.066350] Starting subtest: nonblocking-crc
[188.068104] Starting dynamic subtest: pipe-A-HDMI-A-1
[188.619083] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.550s)
[188.630689] Starting dynamic subtest: pipe-B-HDMI-A-1
[189.218089] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.594s)
[189.220163] Subtest nonblocking-crc: SUCCESS (1.153s)
[189.799106] [117/165] (821s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[190.435186] Starting subtest: nonblocking-crc-frame-sequence
[190.458094] Starting dynamic subtest: pipe-A-HDMI-A-1
[190.988541] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.539s)
[191.012918] Starting dynamic subtest: pipe-B-HDMI-A-1
[191.522196] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.564s)
[191.524120] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.109s)
[192.084756] [118/165] (819s left) kms_pipe_crc_basic (read-crc)
[192.713083] Starting subtest: read-crc
[192.714768] Starting dynamic subtest: pipe-A-HDMI-A-1
[193.208534] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.494s)
[193.220616] Starting dynamic subtest: pipe-B-HDMI-A-1
[193.749768] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.537s)
[193.751849] Subtest read-crc: SUCCESS (1.039s)
[194.350138] [119/165] (817s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[194.987071] Starting subtest: read-crc-frame-sequence
[194.991846] Starting dynamic subtest: pipe-A-HDMI-A-1
[195.468681] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.478s)
[195.481803] Starting dynamic subtest: pipe-B-HDMI-A-1
[195.980781] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.506s)
[195.982765] Subtest read-crc-frame-sequence: SUCCESS (0.990s)
[196.554922] [120/165] (815s left) kms_pm_backlight (basic-brightness)
[197.208516] Subtest basic-brightness: SKIP (0.000s)
[197.488318] [121/165] (814s left) kms_pm_rpm (basic-pci-d3-state)
[209.554674] Subtest basic-pci-d3-state: SKIP (0.000s)
[209.793663] [122/165] (802s left) kms_pm_rpm (basic-rte)
[209.883184] Starting subtest: basic-rte
[221.847846] Subtest basic-rte: SKIP (11.947s)
[222.121780] [123/165] (789s left) kms_psr (primary_page_flip)
[222.216923] Subtest primary_page_flip: SKIP (0.000s)
[222.255505] [124/165] (789s left) kms_psr (cursor_plane_move)
[222.348759] Subtest cursor_plane_move: SKIP (0.000s)
[222.385952] [125/165] (789s left) kms_psr (sprite_plane_onoff)
[222.476264] Subtest sprite_plane_onoff: SKIP (0.000s)
[222.522195] [126/165] (789s left) kms_psr (primary_mmap_gtt)
[222.617893] Subtest primary_mmap_gtt: SKIP (0.000s)
[222.654499] [127/165] (789s left) kms_setmode (basic-clone-single-crtc)
[222.744714] Starting subtest: basic-clone-single-crtc
[222.749586] Subtest basic-clone-single-crtc: SKIP (0.000s)
[222.816704] [128/165] (789s left) i915_pm_rps (basic-api)
[222.914318] Subtest basic-api: SKIP (0.000s)
[222.952977] [129/165] (789s left) prime_self_import (basic-llseek-bad)
[223.041852] Starting subtest: basic-llseek-bad
[223.045690] Subtest basic-llseek-bad: SUCCESS (0.002s)
[223.118169] [130/165] (788s left) prime_self_import (basic-llseek-size)
[223.207080] Starting subtest: basic-llseek-size
[223.210824] Subtest basic-llseek-size: SUCCESS (0.004s)
[223.284496] [131/165] (788s left) prime_self_import (basic-with_fd_dup)
[223.371103] Starting subtest: basic-with_fd_dup
[223.374869] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[223.450712] [132/165] (788s left) prime_self_import (basic-with_one_bo)
[223.541171] Starting subtest: basic-with_one_bo
[223.544567] Subtest basic-with_one_bo: SUCCESS (0.004s)
[223.620100] [133/165] (788s left) prime_self_import (basic-with_one_bo_two_files)
[223.706698] Starting subtest: basic-with_one_bo_two_files
[223.710443] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[223.783981] [134/165] (788s left) prime_self_import (basic-with_two_bos)
[223.872083] Starting subtest: basic-with_two_bos
[223.875786] Subtest basic-with_two_bos: SUCCESS (0.003s)
[223.949375] [135/165] (788s left) prime_vgem (basic-fence-flip)
[224.059918] Starting subtest: basic-fence-flip
[225.141304] Subtest basic-fence-flip: SUCCESS (1.080s)
[225.743320] [136/165] (786s left) prime_vgem (basic-fence-mmap)
[225.853069] Starting subtest: basic-fence-mmap
[225.892682] Subtest basic-fence-mmap: SUCCESS (0.042s)
[225.974673] [137/165] (786s left) prime_vgem (basic-fence-read)
[226.084823] Starting subtest: basic-fence-read
[226.152341] Subtest basic-fence-read: SUCCESS (0.068s)
[226.224845] [138/165] (786s left) prime_vgem (basic-gtt)
[226.336347] Starting subtest: basic-gtt
[226.354048] Subtest basic-gtt: SUCCESS (0.020s)
[226.438321] [139/165] (785s left) prime_vgem (basic-read)
[226.531858] Starting subtest: basic-read
[226.564995] Subtest basic-read: SUCCESS (0.031s)
[226.655069] [140/165] (785s left) prime_vgem (basic-write)
[226.746411] Starting subtest: basic-write
[226.780315] Subtest basic-write: SUCCESS (0.034s)
[226.854817] [141/165] (785s left) vgem_basic (setversion)
[226.960506] Starting subtest: setversion
[226.964365] Subtest setversion: SUCCESS (0.000s)
[227.022181] [142/165] (785s left) vgem_basic (create)
[227.128952] Starting subtest: create
[227.130931] Subtest create: SUCCESS (0.000s)
[227.187419] [143/165] (785s left) vgem_basic (debugfs)
[227.294042] Starting subtest: debugfs
[227.296054] Subtest debugfs: SUCCESS (0.001s)
[227.354844] [144/165] (785s left) vgem_basic (dmabuf-export)
[227.445839] Starting subtest: dmabuf-export
[227.449651] Subtest dmabuf-export: SUCCESS (0.003s)
[227.521461] [145/165] (784s left) vgem_basic (dmabuf-fence)
[227.627596] Starting subtest: dmabuf-fence
[227.629847] Subtest dmabuf-fence: SUCCESS (0.001s)
[227.687570] [146/165] (784s left) vgem_basic (dmabuf-fence-before)
[227.794892] Starting subtest: dmabuf-fence-before
[227.796885] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[227.853833] [147/165] (784s left) vgem_basic (dmabuf-mmap)
[227.958616] Starting subtest: dmabuf-mmap
[227.982153] Subtest dmabuf-mmap: SUCCESS (0.025s)
[228.037168] [148/165] (784s left) vgem_basic (mmap)
[228.141314] Starting subtest: mmap
[228.157908] Subtest mmap: SUCCESS (0.017s)
[228.218358] [149/165] (784s left) vgem_basic (second-client)
[228.308637] Starting subtest: second-client
[228.341183] Subtest second-client: SUCCESS (0.033s)
[228.403249] [150/165] (784s left) vgem_basic (sysfs)
[228.491737] Starting subtest: sysfs
[228.493735] Subtest sysfs: SUCCESS (0.001s)
[228.551703] [151/165] (784s left) core_hotunplug (unbind-rebind)
[228.688944] Starting subtest: unbind-rebind
[231.698333] Subtest unbind-rebind: SUCCESS (3.008s)
[231.727287] [152/165] (780s left) vgem_basic (unload)
[231.836182] Starting subtest: unload
[260.697608] Subtest unload: SUCCESS (28.866s)
[260.801602] [153/165] (751s left) i915_module_load (reload)
[260.886908] Starting subtest: reload
[263.308036] Subtest reload: SUCCESS (2.390s)
[263.388181] [154/165] (749s left) gem_lmem_swapping (basic)
[263.603406] Subtest basic: SKIP (0.000s)
[263.621081] [155/165] (749s left) gem_lmem_swapping (parallel-random-engines)
[264.669828] Subtest parallel-random-engines: SKIP (0.000s)
[265.926303] [156/165] (748s left) gem_lmem_swapping (random-engines)
[266.019991] Subtest random-engines: SKIP (0.000s)
[266.052444] [157/165] (748s left) gem_lmem_swapping (verify-random)
[266.144599] Subtest verify-random: SKIP (0.000s)
[266.186922] [158/165] (747s left) i915_pm_rpm (module-reload)
[278.198779] Subtest module-reload: SKIP (0.000s)
[278.440758] [159/165] (735s left) i915_selftest (live)
[279.115756] Starting subtest: live
[279.117499] Starting dynamic subtest: sanitycheck
[279.859673] Dynamic subtest sanitycheck: SUCCESS (0.742s)
[279.870794] Starting dynamic subtest: uncore
[280.577677] Dynamic subtest uncore: SUCCESS (0.715s)
[280.589370] Starting dynamic subtest: workarounds
[281.268991] Dynamic subtest workarounds: SUCCESS (0.689s)
[281.281843] Starting dynamic subtest: gt_engines
[281.955032] Dynamic subtest gt_engines: SUCCESS (0.682s)
[281.966736] Starting dynamic subtest: gt_timelines
[287.212858] Dynamic subtest gt_timelines: SUCCESS (5.255s)
[287.223647] Starting dynamic subtest: gt_contexts
[287.930964] Dynamic subtest gt_contexts: SUCCESS (0.716s)
[287.944349] Starting dynamic subtest: gt_lrc
[288.610707] Dynamic subtest gt_lrc: SUCCESS (0.676s)
[288.621500] Starting dynamic subtest: gt_mocs
[289.303903] Dynamic subtest gt_mocs: SUCCESS (0.690s)
[289.315260] Starting dynamic subtest: gt_pm
[290.477653] Dynamic subtest gt_pm: SUCCESS (1.171s)
[290.489988] Starting dynamic subtest: gt_heartbeat
[291.212643] Dynamic subtest gt_heartbeat: SUCCESS (0.732s)
[291.223827] Starting dynamic subtest: gt_tlb
[291.899145] Dynamic subtest gt_tlb: SUCCESS (0.683s)
[291.910464] Starting dynamic subtest: requests
[296.173930] Dynamic subtest requests: SUCCESS (4.273s)
[296.185069] Starting dynamic subtest: migrate
[296.894264] Dynamic subtest migrate: SUCCESS (0.717s)
[296.906666] Starting dynamic subtest: active
[297.606463] Dynamic subtest active: SUCCESS (0.709s)
[297.615480] Starting dynamic subtest: objects
[299.704486] Dynamic subtest objects: SUCCESS (2.096s)
[299.713587] Starting dynamic subtest: mman
[305.515685] Dynamic subtest mman: SUCCESS (5.809s)
[305.526877] Starting dynamic subtest: dmabuf
[306.222421] Dynamic subtest dmabuf: SUCCESS (0.705s)
[306.233133] Starting dynamic subtest: vma
[306.949127] Dynamic subtest vma: SUCCESS (0.725s)
[306.960945] Starting dynamic subtest: coherency
[308.784038] Dynamic subtest coherency: SUCCESS (1.832s)
[308.795853] Starting dynamic subtest: gtt
[312.956063] Dynamic subtest gtt: SUCCESS (4.168s)
[312.969254] Starting dynamic subtest: gem
[313.699750] Dynamic subtest gem: SUCCESS (0.741s)
[313.711230] Starting dynamic subtest: evict
[314.382974] Dynamic subtest evict: SUCCESS (0.682s)
[314.394271] Starting dynamic subtest: hugepages
[315.069747] Dynamic subtest hugepages: SUCCESS (0.683s)
[315.081150] Starting dynamic subtest: gem_contexts
[318.869807] Dynamic subtest gem_contexts: SUCCESS (3.797s)
[318.880769] Starting dynamic subtest: client
[319.538040] Dynamic subtest client: SUCCESS (0.667s)
[319.554546] Starting dynamic subtest: gem_migrate
[320.202090] Dynamic subtest gem_migrate: SUCCESS (0.661s)
[320.213983] Starting dynamic subtest: reset
[320.994624] Dynamic subtest reset: SUCCESS (0.789s)
[321.005863] Starting dynamic subtest: memory_region
[321.685995] Dynamic subtest memory_region: SUCCESS (0.689s)
[321.698123] Starting dynamic subtest: hangcheck
[323.952793] Dynamic subtest hangcheck: SUCCESS (2.263s)
[323.962781] Starting dynamic subtest: execlists
[324.606747] Dynamic subtest execlists: SUCCESS (0.651s)
[324.618048] Starting dynamic subtest: ring_submission
[325.303566] Dynamic subtest ring_submission: SUCCESS (0.694s)
[325.314614] Starting dynamic subtest: perf
[325.977847] Dynamic subtest perf: SUCCESS (0.671s)
[325.988259] Starting dynamic subtest: slpc
[326.673729] Dynamic subtest slpc: SUCCESS (0.693s)
[326.685040] Starting dynamic subtest: guc
[327.376878] Dynamic subtest guc: SUCCESS (0.700s)
[327.387974] Starting dynamic subtest: guc_multi_lrc
[328.066989] Dynamic subtest guc_multi_lrc: SUCCESS (0.688s)
[328.078445] Starting dynamic subtest: guc_hang
[328.784957] Dynamic subtest guc_hang: SUCCESS (0.715s)
[328.795977] Starting dynamic subtest: late_gt_pm
[329.483681] Dynamic subtest late_gt_pm: SUCCESS (0.695s)
[329.485557] Subtest live: SUCCESS (50.368s)
[329.513619] [160/165] (684s left) dmabuf (all-tests)
[329.617659] Starting subtest: all-tests
[329.624715] Starting dynamic subtest: sanitycheck
[329.677047] Dynamic subtest sanitycheck: SUCCESS (0.056s)
[329.689054] Starting dynamic subtest: dma_fence
[329.853884] Dynamic subtest dma_fence: SUCCESS (0.177s)
[329.867065] Starting dynamic subtest: dma_fence_chain
[347.033183] Dynamic subtest dma_fence_chain: SUCCESS (17.175s)
[347.046026] Starting dynamic subtest: dma_fence_unwrap
[347.091780] Dynamic subtest dma_fence_unwrap: SUCCESS (0.058s)
[347.105037] Starting dynamic subtest: dma_resv
[347.158704] Dynamic subtest dma_resv: SUCCESS (0.064s)
[347.161528] Subtest all-tests: SUCCESS (17.543s)
[347.184582] [161/165] (667s left) i915_suspend (basic-s2idle-without-i915)
[347.272492] Starting subtest: basic-s2idle-without-i915
[364.815858] Subtest basic-s2idle-without-i915: SUCCESS (3.000s)
[368.106587] [162/165] (663s left) i915_suspend (basic-s3-without-i915)
[368.202055] Starting subtest: basic-s3-without-i915
[386.392674] Subtest basic-s3-without-i915: SUCCESS (2.378s)
[393.627581] [163/165] (661s left) gem_exec_suspend (basic-s0)
[393.741582] Starting subtest: basic-S0
[393.743638] Starting dynamic subtest: smem
[411.467609] Dynamic subtest smem: SUCCESS (10.303s)
[411.469565] Subtest basic-S0: SUCCESS (10.304s)
[416.660882] [164/165] (650s left) gem_exec_suspend (basic-s3)
[416.766574] Starting subtest: basic-S3
[416.769036] Starting dynamic subtest: smem
[433.806992] Dynamic subtest smem: SUCCESS (2.118s)
[433.809144] Subtest basic-S3: SUCCESS (2.120s)
[441.003882] [165/165] (648s left) kms_pipe_crc_basic (suspend-read-crc)
[441.650159] Starting subtest: suspend-read-crc
[441.652365] Starting dynamic subtest: pipe-A-HDMI-A-1
[458.929276] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.209s)
[458.942271] Starting dynamic subtest: pipe-B-HDMI-A-1
[476.887497] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.063s)
[476.889408] Subtest suspend-read-crc: SUCCESS (4.281s)
[485.264244] Closing watchdogs
Done.