[51.986305] Initializing watchdogs
[51.986778]   /dev/watchdog0
[52.005460] [001/165] (960s left) i915_module_load (load)
[52.260772] Starting subtest: load
[55.449259] Subtest load: SUCCESS (3.188s)
[55.556269] [002/165] (957s left) core_auth (basic-auth)
[56.076110] Starting subtest: basic-auth
[56.080428] Subtest basic-auth: SUCCESS (0.009s)
[56.355375] [003/165] (956s left) debugfs_test (read_all_entries)
[56.798987] Starting subtest: read_all_entries
[56.950391] Subtest read_all_entries: SUCCESS (0.148s)
[57.486888] [004/165] (955s left) debugfs_test (basic-hwmon)
[57.738603] Starting subtest: basic-hwmon
[57.741797] Subtest basic-hwmon: SKIP (0.000s)
[58.275043] [005/165] (954s left) fbdev (eof)
[58.540941] Starting subtest: eof
[58.543895] Subtest eof: SUCCESS (0.002s)
[58.636353] [006/165] (954s left) fbdev (info)
[58.850613] Starting subtest: info
[58.852380] Subtest info: SUCCESS (0.000s)
[58.952422] [007/165] (953s left) fbdev (nullptr)
[59.168488] Starting subtest: nullptr
[59.170991] Subtest nullptr: SUCCESS (0.000s)
[59.268639] [008/165] (953s left) fbdev (read)
[59.505176] Starting subtest: read
[63.228108] Subtest read: SUCCESS (3.725s)
[63.328878] [009/165] (949s left) fbdev (write)
[63.590524] Starting subtest: write
[65.481405] Subtest write: SUCCESS (1.888s)
[65.575473] [010/165] (947s left) gem_basic (bad-close)
[65.795368] Starting subtest: bad-close
[65.805187] Subtest bad-close: SUCCESS (0.000s)
[65.893513] [011/165] (947s left) gem_basic (create-close)
[66.118286] Starting subtest: create-close
[66.122564] Subtest create-close: SUCCESS (0.000s)
[66.225748] [012/165] (946s left) gem_basic (create-fd-close)
[66.446099] Starting subtest: create-fd-close
[66.449340] Subtest create-fd-close: SUCCESS (0.001s)
[66.555932] [013/165] (946s left) gem_busy (busy@all-engines)
[66.821196] Starting subtest: busy
[66.824083] Starting dynamic subtest: all-engines
[66.973517] Dynamic subtest all-engines: SUCCESS (0.155s)
[66.975070] Subtest busy: SUCCESS (0.156s)
[67.391256] [014/165] (945s left) gem_close_race (basic-process)
[67.660898] Starting subtest: basic-process
[67.767905] Subtest basic-process: SUCCESS (0.110s)
[67.992717] [015/165] (945s left) gem_close_race (basic-threads)
[68.263984] Starting subtest: basic-threads
[69.495892] Subtest basic-threads: SUCCESS (1.235s)
[69.729737] [016/165] (943s left) gem_ctx_create (basic)
[69.992314] Starting subtest: basic
[69.994142] Subtest basic: SUCCESS (0.000s)
[70.217621] [017/165] (943s left) gem_ctx_create (basic-files)
[70.478853] Starting subtest: basic-files
[72.543193] Subtest basic-files: SUCCESS (2.067s)
[72.816788] [018/165] (940s left) gem_ctx_exec (basic)
[73.069248] Starting subtest: basic
[73.095225] Subtest basic: SUCCESS (0.025s)
[73.214787] [019/165] (940s left) gem_exec_basic (basic)
[73.470569] Starting subtest: basic
[73.474595] Starting dynamic subtest: rcs0-smem
[73.478612] Dynamic subtest rcs0-smem: SUCCESS (0.007s)
[73.509257] Starting dynamic subtest: bcs0-smem
[73.511498] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[73.528188] Starting dynamic subtest: vcs0-smem
[73.531543] Dynamic subtest vcs0-smem: SUCCESS (0.005s)
[73.548876] Starting dynamic subtest: vecs0-smem
[73.550482] Dynamic subtest vecs0-smem: SUCCESS (0.005s)
[73.551986] Subtest basic: SUCCESS (0.027s)
[73.750869] [020/165] (939s left) gem_exec_create (basic)
[74.059287] Starting subtest: basic
[74.062610] Starting dynamic subtest: smem
[76.164089] Dynamic subtest smem: SUCCESS (2.107s)
[76.171717] Subtest basic: SUCCESS (2.108s)
[76.406395] [021/165] (937s left) gem_exec_fence (basic-busy)
[76.828355] Starting subtest: basic-busy
[76.832192] Starting dynamic subtest: rcs0
[76.853541] Dynamic subtest rcs0: SUCCESS (0.027s)
[76.877161] Starting dynamic subtest: bcs0
[76.883112] Dynamic subtest bcs0: SUCCESS (0.024s)
[76.923424] Starting dynamic subtest: vcs0
[76.926352] Dynamic subtest vcs0: SUCCESS (0.024s)
[76.945490] Starting dynamic subtest: vecs0
[76.948241] Dynamic subtest vecs0: SUCCESS (0.027s)
[76.949676] Subtest basic-busy: SUCCESS (0.105s)
[77.702487] [022/165] (935s left) gem_exec_fence (basic-wait)
[78.119840] Starting subtest: basic-wait
[78.121858] Starting dynamic subtest: rcs0
[78.143845] Dynamic subtest rcs0: SUCCESS (0.026s)
[78.165862] Starting dynamic subtest: bcs0
[78.167956] Dynamic subtest bcs0: SUCCESS (0.023s)
[78.188872] Starting dynamic subtest: vcs0
[78.193535] Dynamic subtest vcs0: SUCCESS (0.026s)
[78.215726] Starting dynamic subtest: vecs0
[78.217382] Dynamic subtest vecs0: SUCCESS (0.020s)
[78.218893] Subtest basic-wait: SUCCESS (0.098s)
[78.859192] [023/165] (934s left) gem_exec_fence (basic-await)
[79.285632] Starting subtest: basic-await
[79.288861] Starting dynamic subtest: rcs0
[79.462361] Dynamic subtest rcs0: SUCCESS (0.173s)
[79.485629] Starting dynamic subtest: bcs0
[79.633793] Dynamic subtest bcs0: SUCCESS (0.169s)
[79.656108] Starting dynamic subtest: vcs0
[79.808823] Dynamic subtest vcs0: SUCCESS (0.175s)
[79.832853] Starting dynamic subtest: vecs0
[79.983826] Dynamic subtest vecs0: SUCCESS (0.175s)
[79.985490] Subtest basic-await: SUCCESS (0.700s)
[80.653613] [024/165] (933s left) gem_exec_fence (nb-await)
[81.080159] Starting subtest: nb-await
[81.084045] Starting dynamic subtest: rcs0
[81.165630] Dynamic subtest rcs0: SUCCESS (0.081s)
[81.191688] Starting dynamic subtest: bcs0
[81.242678] Dynamic subtest bcs0: SUCCESS (0.077s)
[81.272230] Starting dynamic subtest: vcs0
[81.320151] Dynamic subtest vcs0: SUCCESS (0.077s)
[81.345434] Starting dynamic subtest: vecs0
[81.404867] Dynamic subtest vecs0: SUCCESS (0.083s)
[81.406858] Subtest nb-await: SUCCESS (0.324s)
[82.055997] [025/165] (931s left) gem_exec_gttfill (basic)
[82.319140] Starting subtest: basic
[84.195402] Subtest basic: SKIP (1.861s)
[84.446169] [026/165] (929s left) gem_exec_parallel (engines)
[84.844827] Starting subtest: engines
[84.849984] Starting dynamic subtest: basic
[90.488264] Dynamic subtest basic: SUCCESS (5.644s)
[90.513697] Starting dynamic subtest: contexts
[99.553866] Dynamic subtest contexts: SUCCESS (9.063s)
[99.586527] Starting dynamic subtest: fds
[112.497815] Dynamic subtest fds: SUCCESS (12.940s)
[112.523427] Starting dynamic subtest: userptr
[117.388934] Dynamic subtest userptr: SUCCESS (4.893s)
[117.391202] Subtest engines: SUCCESS (32.547s)
[117.685167] [027/165] (896s left) gem_exec_store (basic)
[117.946468] Starting subtest: basic
[118.002361] Subtest basic: SUCCESS (0.059s)
[118.259242] [028/165] (895s left) gem_flink_basic (bad-flink)
[118.481761] Starting subtest: bad-flink
[118.484458] Subtest bad-flink: SUCCESS (0.000s)
[118.587746] [029/165] (895s left) gem_flink_basic (bad-open)
[118.812831] Starting subtest: bad-open
[118.815228] Subtest bad-open: SUCCESS (0.000s)
[118.919420] [030/165] (895s left) gem_flink_basic (basic)
[119.144758] Starting subtest: basic
[119.146555] Subtest basic: SUCCESS (0.000s)
[119.258535] [031/165] (894s left) gem_flink_basic (double-flink)
[119.479851] Starting subtest: double-flink
[119.482346] Subtest double-flink: SUCCESS (0.000s)
[119.589511] [032/165] (894s left) gem_flink_basic (flink-lifetime)
[119.813745] Starting subtest: flink-lifetime
[119.817253] Subtest flink-lifetime: SUCCESS (0.005s)
[119.940280] [033/165] (894s left) gem_huc_copy (huc-copy)
[120.175087] Subtest huc-copy: SKIP (0.000s)
[120.244762] [034/165] (894s left) gem_linear_blits (basic)
[120.836758] Subtest basic: SKIP (0.000s)
[120.973409] [035/165] (893s left) gem_mmap (basic)
[121.325747] Starting subtest: basic
[121.335058] Subtest basic: SUCCESS (0.002s)
[121.423564] [036/165] (893s left) gem_mmap_gtt (basic)
[121.648617] Starting subtest: basic
[121.653043] Subtest basic: SUCCESS (0.003s)
[121.744172] [037/165] (892s left) gem_render_linear_blits (basic)
[121.988193] Starting subtest: basic
[122.100072] Subtest basic: SUCCESS (0.109s)
[122.179614] [038/165] (892s left) gem_render_tiled_blits (basic)
[122.414709] Starting subtest: basic
[122.543498] Subtest basic: SUCCESS (0.123s)
[122.629354] [039/165] (891s left) gem_ringfill (basic-all)
[123.047628] Starting subtest: basic-all
[124.441412] Subtest basic-all: SUCCESS (1.394s)
[124.561476] [040/165] (890s left) gem_softpin (allocator-basic)
[124.797620] Starting subtest: allocator-basic
[125.098378] Subtest allocator-basic: SUCCESS (0.291s)
[125.257349] [041/165] (889s left) gem_softpin (allocator-basic-reserve)
[125.490852] Starting subtest: allocator-basic-reserve
[125.776718] Subtest allocator-basic-reserve: SUCCESS (0.282s)
[125.964403] [042/165] (888s left) gem_softpin (safe-alignment)
[126.211217] Starting subtest: safe-alignment
[126.254681] Subtest safe-alignment: SUCCESS (0.044s)
[126.366260] [043/165] (888s left) gem_sync (basic-all)
[126.635678] Starting subtest: basic-all
[129.318126] Subtest basic-all: SUCCESS (2.685s)
[129.554069] [044/165] (885s left) gem_sync (basic-each)
[129.829676] Starting subtest: basic-each
[132.490545] Subtest basic-each: SUCCESS (2.661s)
[132.752970] [045/165] (882s left) gem_tiled_blits (basic)
[133.313544] Subtest basic: SKIP (0.000s)
[133.414712] [046/165] (881s left) gem_tiled_fence_blits (basic)
[134.098866] Starting subtest: basic
[134.157359] Subtest basic: SUCCESS (0.057s)
[134.305191] [047/165] (880s left) gem_tiled_pread_basic
[135.469912] [048/165] (879s left) gem_wait (busy@all-engines)
[135.763872] Starting subtest: busy
[135.766870] Starting dynamic subtest: all-engines
[136.302126] Dynamic subtest all-engines: SUCCESS (0.535s)
[136.303844] Subtest busy: SUCCESS (0.536s)
[136.621732] [049/165] (878s left) gem_wait (wait@all-engines)
[136.902448] Starting subtest: wait
[136.904907] Starting dynamic subtest: all-engines
[137.935438] Dynamic subtest all-engines: SUCCESS (1.036s)
[137.937720] Subtest wait: SUCCESS (1.038s)
[138.242202] [050/165] (876s left) i915_getparams_basic (basic-eu-total)
[138.480158] Starting subtest: basic-eu-total
[138.484488] Subtest basic-eu-total: SUCCESS (0.000s)
[138.589227] [051/165] (876s left) i915_getparams_basic (basic-subslice-total)
[138.816800] Starting subtest: basic-subslice-total
[138.822351] Subtest basic-subslice-total: SUCCESS (0.000s)
[138.905606] [052/165] (876s left) i915_hangman (error-state-basic)
[139.160708] Starting subtest: error-state-basic
[139.182726] Subtest error-state-basic: SUCCESS (0.027s)
[139.315396] [053/165] (876s left) i915_pciid
[139.636686] [054/165] (875s left) kms_addfb_basic (addfb25-4-tiled)
[140.326129] Starting subtest: addfb25-4-tiled
[140.329161] Subtest addfb25-4-tiled: SUCCESS (0.004s)
[140.425310] [055/165] (875s left) kms_addfb_basic (addfb25-bad-modifier)
[140.648410] Starting subtest: addfb25-bad-modifier
[140.652348] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[141.193203] [056/165] (874s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[141.418122] Starting subtest: addfb25-framebuffer-vs-set-tiling
[141.419629] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[141.926281] [057/165] (873s left) kms_addfb_basic (addfb25-modifier-no-flag)
[142.147202] Starting subtest: addfb25-modifier-no-flag
[142.148908] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[142.677917] [058/165] (872s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[142.899112] Starting subtest: addfb25-x-tiled-legacy
[142.900650] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[143.482510] [059/165] (872s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[143.733667] Starting subtest: addfb25-x-tiled-mismatch-legacy
[143.739713] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[144.277226] [060/165] (871s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[144.927400] Starting subtest: addfb25-yf-tiled-legacy
[144.929534] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[145.046591] [061/165] (870s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[145.696459] Starting subtest: addfb25-y-tiled-legacy
[145.698314] Subtest addfb25-y-tiled-legacy: SUCCESS (0.003s)
[145.811732] [062/165] (870s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[146.428526] Starting subtest: addfb25-y-tiled-small-legacy
[146.432312] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[146.528774] [063/165] (869s left) kms_addfb_basic (bad-pitch-0)
[146.753629] Starting subtest: bad-pitch-0
[146.755264] Subtest bad-pitch-0: SUCCESS (0.000s)
[147.262995] [064/165] (868s left) kms_addfb_basic (bad-pitch-1024)
[147.485863] Starting subtest: bad-pitch-1024
[147.489050] Subtest bad-pitch-1024: SUCCESS (0.000s)
[148.015419] [065/165] (868s left) kms_addfb_basic (bad-pitch-128)
[148.236197] Starting subtest: bad-pitch-128
[148.237738] Subtest bad-pitch-128: SUCCESS (0.000s)
[148.748148] [066/165] (867s left) kms_addfb_basic (bad-pitch-256)
[148.974314] Starting subtest: bad-pitch-256
[148.977624] Subtest bad-pitch-256: SUCCESS (0.000s)
[149.467315] [067/165] (866s left) kms_addfb_basic (bad-pitch-32)
[149.691556] Starting subtest: bad-pitch-32
[149.694573] Subtest bad-pitch-32: SUCCESS (0.000s)
[150.213720] [068/165] (866s left) kms_addfb_basic (bad-pitch-63)
[150.443613] Starting subtest: bad-pitch-63
[150.445280] Subtest bad-pitch-63: SUCCESS (0.000s)
[150.967546] [069/165] (865s left) kms_addfb_basic (bad-pitch-65536)
[151.190451] Starting subtest: bad-pitch-65536
[151.195237] Subtest bad-pitch-65536: SUCCESS (0.001s)
[151.714908] [070/165] (864s left) kms_addfb_basic (bad-pitch-999)
[151.944577] Starting subtest: bad-pitch-999
[151.946129] Subtest bad-pitch-999: SUCCESS (0.000s)
[152.469312] [071/165] (863s left) kms_addfb_basic (basic)
[152.690203] Starting subtest: basic
[152.692289] Subtest basic: SUCCESS (0.000s)
[153.201704] [072/165] (863s left) kms_addfb_basic (basic-x-tiled-legacy)
[153.427954] Starting subtest: basic-x-tiled-legacy
[153.429638] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[153.950086] [073/165] (862s left) kms_addfb_basic (basic-y-tiled-legacy)
[154.178657] Starting subtest: basic-y-tiled-legacy
[154.180252] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[154.704083] [074/165] (861s left) kms_addfb_basic (bo-too-small)
[155.343225] Starting subtest: bo-too-small
[155.345555] Subtest bo-too-small: SUCCESS (0.001s)
[155.453688] [075/165] (861s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[156.110940] Starting subtest: bo-too-small-due-to-tiling
[156.113264] Subtest bo-too-small-due-to-tiling: SUCCESS (0.004s)
[156.222637] [076/165] (860s left) kms_addfb_basic (clobberred-modifier)
[156.443504] Starting subtest: clobberred-modifier
[156.446928] Subtest clobberred-modifier: SUCCESS (0.000s)
[156.972373] [077/165] (859s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[157.204072] Starting subtest: framebuffer-vs-set-tiling
[157.205652] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[157.738282] [078/165] (859s left) kms_addfb_basic (invalid-get-prop)
[157.964328] Starting subtest: invalid-get-prop
[157.966048] Subtest invalid-get-prop: SUCCESS (0.000s)
[158.474815] [079/165] (858s left) kms_addfb_basic (invalid-get-prop-any)
[158.701630] Starting subtest: invalid-get-prop-any
[158.703902] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[159.239732] [080/165] (857s left) kms_addfb_basic (invalid-set-prop)
[159.464383] Starting subtest: invalid-set-prop
[159.466036] Subtest invalid-set-prop: SUCCESS (0.000s)
[159.990554] [081/165] (856s left) kms_addfb_basic (invalid-set-prop-any)
[160.209783] Starting subtest: invalid-set-prop-any
[160.213581] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[160.724985] [082/165] (856s left) kms_addfb_basic (no-handle)
[160.945670] Starting subtest: no-handle
[160.947217] Subtest no-handle: SUCCESS (0.000s)
[161.475976] [083/165] (855s left) kms_addfb_basic (size-max)
[162.126691] Starting subtest: size-max
[162.128517] Subtest size-max: SUCCESS (0.000s)
[162.226481] [084/165] (854s left) kms_addfb_basic (small-bo)
[162.874421] Starting subtest: small-bo
[162.877841] Subtest small-bo: SUCCESS (0.000s)
[162.974997] [085/165] (854s left) kms_addfb_basic (tile-pitch-mismatch)
[163.207994] Starting subtest: tile-pitch-mismatch
[163.209953] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[163.743795] [086/165] (853s left) kms_addfb_basic (too-high)
[164.384350] Starting subtest: too-high
[164.388556] Subtest too-high: SUCCESS (0.005s)
[164.494629] [087/165] (852s left) kms_addfb_basic (too-wide)
[165.162466] Starting subtest: too-wide
[165.165963] Subtest too-wide: SUCCESS (0.000s)
[165.262773] [088/165] (851s left) kms_addfb_basic (unused-handle)
[165.490478] Starting subtest: unused-handle
[165.493199] Subtest unused-handle: SUCCESS (0.000s)
[165.996736] [089/165] (851s left) kms_addfb_basic (unused-modifier)
[166.219196] Starting subtest: unused-modifier
[166.222224] Subtest unused-modifier: SUCCESS (0.000s)
[166.746241] [090/165] (850s left) kms_addfb_basic (unused-offsets)
[166.969592] Starting subtest: unused-offsets
[166.972824] Subtest unused-offsets: SUCCESS (0.000s)
[167.494710] [091/165] (849s left) kms_addfb_basic (unused-pitches)
[167.717264] Starting subtest: unused-pitches
[167.719633] Subtest unused-pitches: SUCCESS (0.000s)
[168.233259] [092/165] (849s left) kms_busy (basic)
[168.891058] Starting subtest: basic
[168.902797] Starting dynamic subtest: flip
[170.052064] Dynamic subtest flip: SUCCESS (1.140s)
[170.122710] Starting dynamic subtest: modeset
[172.105095] Dynamic subtest modeset: SUCCESS (2.048s)
[172.114087] Subtest basic: SUCCESS (3.198s)
[172.697176] [093/165] (844s left) kms_prop_blob (basic)
[172.931823] Starting subtest: basic
[172.933936] Subtest basic: SUCCESS (0.000s)
[173.037495] [094/165] (844s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[173.673739] Starting subtest: basic-busy-flip-before-cursor-atomic
[174.918142] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.246s)
[175.423471] [095/165] (842s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[176.073632] Starting subtest: basic-busy-flip-before-cursor-legacy
[177.306282] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.237s)
[177.751193] [096/165] (839s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[178.392904] Starting subtest: basic-flip-after-cursor-atomic
[179.660895] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.274s)
[180.192130] [097/165] (837s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[180.886393] Starting subtest: basic-flip-after-cursor-legacy
[182.133747] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.249s)
[182.622512] [098/165] (835s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[183.276677] Starting subtest: basic-flip-after-cursor-varying-size
[184.470042] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.192s)
[184.938310] [099/165] (832s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[185.587107] Starting subtest: basic-flip-before-cursor-atomic
[186.796610] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.207s)
[187.292623] [100/165] (830s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[187.953043] Starting subtest: basic-flip-before-cursor-legacy
[189.152081] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.199s)
[189.679510] [101/165] (828s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[190.337193] Starting subtest: basic-flip-before-cursor-varying-size
[191.611129] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.271s)
[192.125899] [102/165] (825s left) kms_dsc (dsc-basic)
[192.809433] Subtest dsc-basic: SKIP (0.000s)
[192.893252] [103/165] (825s left) kms_flip (basic-flip-vs-dpms)
[193.553888] Starting subtest: basic-flip-vs-dpms
[193.572486] Starting dynamic subtest: C-HDMI-A2
[196.288816] Dynamic subtest C-HDMI-A2: SUCCESS (2.717s)
[196.293315] Subtest basic-flip-vs-dpms: SUCCESS (2.744s)
[196.783264] [104/165] (821s left) kms_flip (basic-flip-vs-modeset)
[197.477240] Starting subtest: basic-flip-vs-modeset
[197.483925] Starting dynamic subtest: C-HDMI-A2
[200.291338] Dynamic subtest C-HDMI-A2: SUCCESS (2.799s)
[200.297550] Subtest basic-flip-vs-modeset: SUCCESS (2.821s)
[201.019349] [105/165] (817s left) kms_flip (basic-flip-vs-wf_vblank)
[201.742584] Starting subtest: basic-flip-vs-wf_vblank
[201.755494] Starting dynamic subtest: C-HDMI-A2
[204.710083] Dynamic subtest C-HDMI-A2: SUCCESS (2.945s)
[204.711709] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.970s)
[204.879178] [106/165] (813s left) kms_flip (basic-plain-flip)
[205.578579] Starting subtest: basic-plain-flip
[205.595963] Starting dynamic subtest: C-HDMI-A2
[208.261751] Dynamic subtest C-HDMI-A2: SUCCESS (2.664s)
[208.263334] Subtest basic-plain-flip: SUCCESS (2.692s)
[208.448589] [107/165] (809s left) kms_force_connector_basic (force-connector-state)
[208.801050] Starting subtest: force-connector-state
[209.600383] Subtest force-connector-state: SUCCESS (0.798s)
[210.992386] [108/165] (807s left) kms_force_connector_basic (force-edid)
[211.342239] Starting subtest: force-edid
[211.450531] Subtest force-edid: SUCCESS (0.105s)
[212.242432] [109/165] (806s left) kms_force_connector_basic (force-load-detect)
[212.585091] Starting subtest: force-load-detect
[212.593437] Subtest force-load-detect: SKIP (0.000s)
[213.140708] [110/165] (805s left) kms_force_connector_basic (prune-stale-modes)
[213.522218] Starting subtest: prune-stale-modes
[213.620413] Subtest prune-stale-modes: SUCCESS (0.102s)
[214.428597] [111/165] (804s left) kms_frontbuffer_tracking (basic)
[215.196518] Starting subtest: basic
[219.906509] Subtest basic: SUCCESS (4.713s)
[220.066487] [112/165] (798s left) kms_hdmi_inject (inject-audio)
[220.414826] Starting subtest: inject-audio
[221.432451] Subtest inject-audio: FAIL (0.938s)
[222.327086] [113/165] (796s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[223.015361] Starting subtest: compare-crc-sanitycheck-xr24
[223.029238] Starting dynamic subtest: pipe-C-HDMI-A-2
[223.585770] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.564s)
[223.615111] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.583s)
[224.084663] [114/165] (794s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[224.774938] Starting subtest: compare-crc-sanitycheck-nv12
[224.791155] Starting dynamic subtest: pipe-C-HDMI-A-2
[224.795096] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[224.800994] Subtest compare-crc-sanitycheck-nv12: SKIP (0.016s)
[224.901495] [115/165] (793s left) kms_pipe_crc_basic (hang-read-crc)
[225.598634] Starting subtest: hang-read-crc
[225.602557] Starting dynamic subtest: pipe-C-HDMI-A-2
[227.295393] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.695s)
[227.297207] Subtest hang-read-crc: SUCCESS (1.706s)
[227.789194] [116/165] (791s left) kms_pipe_crc_basic (nonblocking-crc)
[228.502408] Starting subtest: nonblocking-crc
[228.505084] Starting dynamic subtest: pipe-C-HDMI-A-2
[229.252865] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.748s)
[229.254479] Subtest nonblocking-crc: SUCCESS (0.757s)
[229.772302] [117/165] (789s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[230.475721] Starting subtest: nonblocking-crc-frame-sequence
[230.478968] Starting dynamic subtest: pipe-C-HDMI-A-2
[231.230934] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.754s)
[231.239140] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.768s)
[231.700979] [118/165] (787s left) kms_pipe_crc_basic (read-crc)
[232.394034] Starting subtest: read-crc
[232.397088] Starting dynamic subtest: pipe-C-HDMI-A-2
[233.087622] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.693s)
[233.089239] Subtest read-crc: SUCCESS (0.703s)
[233.614472] [119/165] (785s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[234.302664] Starting subtest: read-crc-frame-sequence
[234.305081] Starting dynamic subtest: pipe-C-HDMI-A-2
[234.995856] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.693s)
[234.997392] Subtest read-crc-frame-sequence: SUCCESS (0.701s)
[235.526738] [120/165] (783s left) kms_pm_backlight (basic-brightness)
[236.191717] Subtest basic-brightness: SKIP (0.000s)
[236.288486] [121/165] (782s left) kms_pm_rpm (basic-pci-d3-state)
[238.654947] Starting subtest: basic-pci-d3-state
[239.027140] Subtest basic-pci-d3-state: SUCCESS (0.363s)
[239.395981] [122/165] (779s left) kms_pm_rpm (basic-rte)
[239.615734] Starting subtest: basic-rte
[242.098159] Subtest basic-rte: SUCCESS (2.472s)
[243.339777] [123/165] (775s left) kms_psr (psr_primary_page_flip)
[244.012351] Subtest psr_primary_page_flip: SKIP (0.000s)
[244.095406] [124/165] (775s left) kms_psr (psr_cursor_plane_move)
[244.790477] Subtest psr_cursor_plane_move: SKIP (0.000s)
[244.873305] [125/165] (774s left) kms_psr (psr_sprite_plane_onoff)
[245.608040] Subtest psr_sprite_plane_onoff: SKIP (0.000s)
[245.694179] [126/165] (773s left) kms_psr (psr_primary_mmap_gtt)
[246.389980] Subtest psr_primary_mmap_gtt: SKIP (0.000s)
[246.475208] [127/165] (773s left) kms_setmode (basic-clone-single-crtc)
[246.708561] Starting subtest: basic-clone-single-crtc
[246.715060] Subtest basic-clone-single-crtc: SKIP (0.001s)
[246.820374] [128/165] (772s left) i915_pm_rps (basic-api)
[247.072588] Starting subtest: basic-api
[247.082716] Subtest basic-api: SUCCESS (0.014s)
[247.204267] [129/165] (772s left) prime_self_import (basic-llseek-bad)
[247.429843] Starting subtest: basic-llseek-bad
[247.433853] Subtest basic-llseek-bad: SUCCESS (0.007s)
[247.543618] [130/165] (772s left) prime_self_import (basic-llseek-size)
[247.770526] Starting subtest: basic-llseek-size
[247.783943] Subtest basic-llseek-size: SUCCESS (0.013s)
[247.887709] [131/165] (771s left) prime_self_import (basic-with_fd_dup)
[248.105915] Starting subtest: basic-with_fd_dup
[248.118801] Subtest basic-with_fd_dup: SUCCESS (0.011s)
[248.249258] [132/165] (771s left) prime_self_import (basic-with_one_bo)
[248.468087] Starting subtest: basic-with_one_bo
[248.478554] Subtest basic-with_one_bo: SUCCESS (0.015s)
[248.615978] [133/165] (771s left) prime_self_import (basic-with_one_bo_two_files)
[248.841404] Starting subtest: basic-with_one_bo_two_files
[248.846704] Subtest basic-with_one_bo_two_files: SUCCESS (0.009s)
[248.955797] [134/165] (770s left) prime_self_import (basic-with_two_bos)
[249.175646] Starting subtest: basic-with_two_bos
[249.185836] Subtest basic-with_two_bos: SUCCESS (0.013s)
[249.306423] [135/165] (770s left) prime_vgem (basic-fence-flip)
[249.556630] Starting subtest: basic-fence-flip
[250.395698] Subtest basic-fence-flip: SKIP (0.837s)
[250.579205] [136/165] (769s left) prime_vgem (basic-fence-mmap)
[250.851272] Starting subtest: basic-fence-mmap
[250.966818] Subtest basic-fence-mmap: SUCCESS (0.114s)
[251.103253] [137/165] (768s left) prime_vgem (basic-fence-read)
[251.361402] Starting subtest: basic-fence-read
[251.543997] Subtest basic-fence-read: SUCCESS (0.183s)
[251.659128] [138/165] (768s left) prime_vgem (basic-gtt)
[251.903741] Starting subtest: basic-gtt
[251.948067] Subtest basic-gtt: SUCCESS (0.044s)
[252.081802] [139/165] (768s left) prime_vgem (basic-read)
[252.345640] Starting subtest: basic-read
[252.425095] Subtest basic-read: SUCCESS (0.076s)
[252.542733] [140/165] (767s left) prime_vgem (basic-write)
[252.793150] Starting subtest: basic-write
[252.884720] Subtest basic-write: SUCCESS (0.092s)
[253.029703] [141/165] (767s left) vgem_basic (setversion)
[253.268288] Starting subtest: setversion
[253.278165] Subtest setversion: SUCCESS (0.000s)
[253.362816] [142/165] (767s left) vgem_basic (create)
[253.607747] Starting subtest: create
[253.609553] Subtest create: SUCCESS (0.001s)
[253.703684] [143/165] (766s left) vgem_basic (debugfs)
[253.940762] Starting subtest: debugfs
[253.942670] Subtest debugfs: SUCCESS (0.002s)
[254.027723] [144/165] (766s left) vgem_basic (dmabuf-export)
[254.257901] Starting subtest: dmabuf-export
[254.262544] Subtest dmabuf-export: SUCCESS (0.007s)
[254.378316] [145/165] (766s left) vgem_basic (dmabuf-fence)
[254.606443] Starting subtest: dmabuf-fence
[254.608281] Subtest dmabuf-fence: SUCCESS (0.003s)
[254.692879] [146/165] (765s left) vgem_basic (dmabuf-fence-before)
[254.919257] Starting subtest: dmabuf-fence-before
[254.926834] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[255.011614] [147/165] (765s left) vgem_basic (dmabuf-mmap)
[255.238565] Starting subtest: dmabuf-mmap
[255.279086] Subtest dmabuf-mmap: SUCCESS (0.038s)
[255.370243] [148/165] (765s left) vgem_basic (mmap)
[255.605041] Starting subtest: mmap
[255.634604] Subtest mmap: SUCCESS (0.028s)
[255.731571] [149/165] (765s left) vgem_basic (second-client)
[255.975148] Starting subtest: second-client
[256.021142] Subtest second-client: SUCCESS (0.045s)
[256.115969] [150/165] (764s left) vgem_basic (sysfs)
[256.357482] Starting subtest: sysfs
[256.362699] Subtest sysfs: SUCCESS (0.004s)
[256.469232] [151/165] (764s left) core_hotunplug (unbind-rebind)
[256.790787] Starting subtest: unbind-rebind
[261.291221] Subtest unbind-rebind: SUCCESS (4.496s)
[261.414326] [152/165] (759s left) vgem_basic (unload)
[261.650995] Starting subtest: unload
[290.774170] Subtest unload: SUCCESS (29.120s)
[290.989707] [153/165] (730s left) i915_module_load (reload)
[291.208510] Starting subtest: reload
[295.990072] Subtest reload: SUCCESS (4.781s)
[296.121740] [154/165] (725s left) gem_lmem_swapping (basic)
[296.633826] Subtest basic: SKIP (0.000s)
[296.715175] [155/165] (724s left) gem_lmem_swapping (parallel-random-engines)
[296.952619] Subtest parallel-random-engines: SKIP (0.000s)
[297.033290] [156/165] (724s left) gem_lmem_swapping (random-engines)
[297.271453] Subtest random-engines: SKIP (0.000s)
[297.347668] [157/165] (724s left) gem_lmem_swapping (verify-random)
[297.580128] Subtest verify-random: SKIP (0.000s)
[297.667281] [158/165] (723s left) i915_pm_rpm (module-reload)
[300.396310] Starting subtest: module-reload
[312.231234] Subtest module-reload: SUCCESS (11.849s)
[312.284962] [159/165] (709s left) i915_selftest (live)
[312.540277] Starting subtest: live
[312.542045] Starting dynamic subtest: sanitycheck
[314.263288] Dynamic subtest sanitycheck: SUCCESS (1.722s)
[314.329769] Starting dynamic subtest: uncore
[316.179357] Dynamic subtest uncore: SUCCESS (1.901s)
[316.197607] Starting dynamic subtest: workarounds
[318.125323] Dynamic subtest workarounds: SUCCESS (1.942s)
[318.146421] Starting dynamic subtest: gt_engines
[320.320884] Dynamic subtest gt_engines: SUCCESS (2.195s)
[320.343380] Starting dynamic subtest: gt_timelines
[349.113090] Dynamic subtest gt_timelines: SUCCESS (28.782s)
[349.132299] Starting dynamic subtest: gt_contexts
[351.062708] Dynamic subtest gt_contexts: SUCCESS (1.946s)
[351.085911] Starting dynamic subtest: gt_lrc
[356.206671] Dynamic subtest gt_lrc: SUCCESS (5.132s)
[356.225772] Starting dynamic subtest: gt_mocs
[357.969727] Dynamic subtest gt_mocs: SUCCESS (1.763s)
[358.020969] Starting dynamic subtest: gt_pm
[361.005064] Dynamic subtest gt_pm: SUCCESS (3.013s)
[361.023602] Starting dynamic subtest: gt_heartbeat
[362.939089] Dynamic subtest gt_heartbeat: SUCCESS (1.931s)
[362.959729] Starting dynamic subtest: gt_tlb
[365.084089] Dynamic subtest gt_tlb: SUCCESS (2.138s)
[365.102966] Starting dynamic subtest: requests
[373.331700] Dynamic subtest requests: SUCCESS (8.244s)
[373.350097] Starting dynamic subtest: migrate
[378.582574] Dynamic subtest migrate: SUCCESS (5.250s)
[378.610777] Starting dynamic subtest: active
[380.457847] Dynamic subtest active: SUCCESS (1.869s)
[380.476631] Starting dynamic subtest: objects
[384.264928] Dynamic subtest objects: SUCCESS (3.803s)
[384.288131] Starting dynamic subtest: mman
[394.246052] Dynamic subtest mman: SUCCESS (9.972s)
[394.264916] Starting dynamic subtest: dmabuf
[396.139184] Dynamic subtest dmabuf: SUCCESS (1.891s)
[396.165227] Starting dynamic subtest: vma
[397.929058] Dynamic subtest vma: SUCCESS (1.783s)
[397.947812] Starting dynamic subtest: coherency
[403.337082] Dynamic subtest coherency: SUCCESS (5.403s)
[403.356143] Starting dynamic subtest: gtt
[412.684396] Dynamic subtest gtt: SUCCESS (9.346s)
[412.708254] Starting dynamic subtest: gem
[415.465332] Dynamic subtest gem: SUCCESS (2.772s)
[415.503779] Starting dynamic subtest: evict
[423.442794] Dynamic subtest evict: SUCCESS (7.977s)
[423.468259] Starting dynamic subtest: hugepages
[425.746412] Dynamic subtest hugepages: SUCCESS (2.296s)
[425.771759] Starting dynamic subtest: gem_contexts
[450.169317] Dynamic subtest gem_contexts: SUCCESS (24.413s)
[450.187776] Starting dynamic subtest: client
[452.068081] Dynamic subtest client: SUCCESS (1.895s)
[452.086974] Starting dynamic subtest: gem_migrate
[453.772714] Dynamic subtest gem_migrate: SUCCESS (1.699s)
[453.809333] Starting dynamic subtest: reset
[463.632767] Dynamic subtest reset: SUCCESS (9.854s)
[463.651420] Starting dynamic subtest: memory_region
[465.412282] Dynamic subtest memory_region: SUCCESS (1.780s)
[465.448143] Starting dynamic subtest: hangcheck
[490.331235] Dynamic subtest hangcheck: SUCCESS (24.911s)
[490.373132] Starting dynamic subtest: execlists
[502.315744] Dynamic subtest execlists: SUCCESS (11.976s)
[502.335609] Starting dynamic subtest: ring_submission
[504.090111] Dynamic subtest ring_submission: SUCCESS (1.770s)
[504.109328] Starting dynamic subtest: perf
[506.241718] Dynamic subtest perf: SUCCESS (2.147s)
[506.260432] Starting dynamic subtest: slpc
[507.974846] Dynamic subtest slpc: SUCCESS (1.732s)
[508.044181] Starting dynamic subtest: guc
[509.807871] Dynamic subtest guc: SUCCESS (1.822s)
[509.830842] Starting dynamic subtest: guc_multi_lrc
[511.567781] Dynamic subtest guc_multi_lrc: SUCCESS (1.754s)
[511.588127] Starting dynamic subtest: guc_hang
[513.353661] Dynamic subtest guc_hang: SUCCESS (1.781s)
[513.377444] Starting dynamic subtest: late_gt_pm
[515.253392] Dynamic subtest late_gt_pm: SUCCESS (1.894s)
[515.255891] Subtest live: SUCCESS (202.716s)
[515.311592] [160/165] (506s left) dmabuf (all-tests)
[515.548638] Starting subtest: all-tests
[515.555298] Starting dynamic subtest: sanitycheck
[515.615122] Dynamic subtest sanitycheck: SUCCESS (0.065s)
[515.644101] Starting dynamic subtest: dma_fence
[515.818892] Dynamic subtest dma_fence: SUCCESS (0.196s)
[515.866054] Starting dynamic subtest: dma_fence_chain
[546.484384] Dynamic subtest dma_fence_chain: SUCCESS (30.655s)
[546.525963] Starting dynamic subtest: dma_fence_unwrap
[546.562047] Dynamic subtest dma_fence_unwrap: SUCCESS (0.070s)
[546.615736] Starting dynamic subtest: dma_resv
[546.643802] Dynamic subtest dma_resv: SUCCESS (0.071s)
[546.646249] Subtest all-tests: SUCCESS (31.099s)
[546.697364] [161/165] (474s left) i915_suspend (basic-s2idle-without-i915)
[546.911614] Starting subtest: basic-s2idle-without-i915
[568.545746] Subtest basic-s2idle-without-i915: SUCCESS (7.596s)
[571.081143] [162/165] (466s left) i915_suspend (basic-s3-without-i915)
[571.324550] Starting subtest: basic-s3-without-i915
[592.246276] Subtest basic-s3-without-i915: SUCCESS (5.854s)
[594.891759] [163/165] (459s left) gem_exec_suspend (basic-s0)
[595.245684] Starting subtest: basic-S0
[595.247318] Starting dynamic subtest: smem
[617.866906] Dynamic subtest smem: SUCCESS (7.677s)
[617.869512] Subtest basic-S0: SUCCESS (7.682s)
[620.076199] [164/165] (451s left) gem_exec_suspend (basic-s3)
[620.347650] Starting subtest: basic-S3
[620.350514] Starting dynamic subtest: smem
[644.047445] Dynamic subtest smem: SUCCESS (8.967s)
[644.051884] Subtest basic-S3: SUCCESS (8.971s)
[645.257706] [165/165] (442s left) kms_pipe_crc_basic (suspend-read-crc)
[646.014036] Starting subtest: suspend-read-crc
[646.031241] Starting dynamic subtest: pipe-C-HDMI-A-2
[666.622587] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (4.456s)
[666.625897] Subtest suspend-read-crc: SUCCESS (4.473s)
[668.948721] Closing watchdogs
Done.