[127.335664] Initializing watchdogs
[127.335956]   /dev/watchdog0
[127.353329] [001/165] (960s left) i915_module_load (load)
[127.612202] Starting subtest: load
[130.982179] Subtest load: SUCCESS (3.373s)
[131.135754] [002/165] (956s left) core_auth (basic-auth)
[131.757816] Starting subtest: basic-auth
[131.765505] Subtest basic-auth: SUCCESS (0.010s)
[131.966460] [003/165] (956s left) debugfs_test (read_all_entries)
[132.226624] Starting subtest: read_all_entries
[132.407096] Subtest read_all_entries: SUCCESS (0.177s)
[132.948044] [004/165] (955s left) debugfs_test (basic-hwmon)
[133.193535] Starting subtest: basic-hwmon
[133.198362] Subtest basic-hwmon: SKIP (0.000s)
[133.698723] [005/165] (954s left) fbdev (eof)
[133.937480] Starting subtest: eof
[133.942570] Subtest eof: SUCCESS (0.004s)
[134.031721] [006/165] (954s left) fbdev (info)
[134.249603] Starting subtest: info
[134.251330] Subtest info: SUCCESS (0.000s)
[134.352961] [007/165] (953s left) fbdev (nullptr)
[134.585648] Starting subtest: nullptr
[134.587527] Subtest nullptr: SUCCESS (0.000s)
[134.666037] [008/165] (953s left) fbdev (read)
[134.903911] Starting subtest: read
[136.986625] Subtest read: SUCCESS (2.077s)
[137.071363] [009/165] (951s left) fbdev (write)
[137.299433] Starting subtest: write
[138.366882] Subtest write: SUCCESS (1.064s)
[138.449152] [010/165] (949s left) gem_basic (bad-close)
[138.676825] Starting subtest: bad-close
[138.681658] Subtest bad-close: SUCCESS (0.000s)
[138.783410] [011/165] (949s left) gem_basic (create-close)
[139.019292] Starting subtest: create-close
[139.023207] Subtest create-close: SUCCESS (0.000s)
[139.117205] [012/165] (949s left) gem_basic (create-fd-close)
[139.342083] Starting subtest: create-fd-close
[139.346236] Subtest create-fd-close: SUCCESS (0.001s)
[139.448413] [013/165] (949s left) gem_busy (busy@all-engines)
[139.724475] Starting subtest: busy
[139.726931] Starting dynamic subtest: all-engines
[139.884202] Dynamic subtest all-engines: SUCCESS (0.159s)
[139.885825] Subtest busy: SUCCESS (0.161s)
[140.300131] [014/165] (948s left) gem_close_race (basic-process)
[140.587207] Starting subtest: basic-process
[140.706083] Subtest basic-process: SUCCESS (0.125s)
[140.952452] [015/165] (947s left) gem_close_race (basic-threads)
[141.240932] Starting subtest: basic-threads
[142.450809] Subtest basic-threads: SUCCESS (1.212s)
[142.682705] [016/165] (946s left) gem_ctx_create (basic)
[142.951240] Starting subtest: basic
[142.952730] Subtest basic: SUCCESS (0.000s)
[143.181620] [017/165] (945s left) gem_ctx_create (basic-files)
[143.458398] Starting subtest: basic-files
[145.532204] Subtest basic-files: SUCCESS (2.070s)
[145.762838] [018/165] (943s left) gem_ctx_exec (basic)
[145.999759] Starting subtest: basic
[146.018601] Subtest basic: SUCCESS (0.014s)
[146.133209] [019/165] (942s left) gem_exec_basic (basic)
[146.393102] Starting subtest: basic
[146.396828] Starting dynamic subtest: rcs0-smem
[146.398875] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[146.419807] Starting dynamic subtest: bcs0-smem
[146.421286] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[146.438061] Starting dynamic subtest: vcs0-smem
[146.439527] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[146.457048] Starting dynamic subtest: vecs0-smem
[146.458548] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[146.459907] Subtest basic: SUCCESS (0.017s)
[146.634323] [020/165] (942s left) gem_exec_create (basic)
[146.903307] Starting subtest: basic
[146.904970] Starting dynamic subtest: smem
[148.992324] Dynamic subtest smem: SUCCESS (2.091s)
[148.994160] Subtest basic: SUCCESS (2.092s)
[149.214394] [021/165] (939s left) gem_exec_fence (basic-busy)
[149.641345] Starting subtest: basic-busy
[149.644063] Starting dynamic subtest: rcs0
[149.663523] Dynamic subtest rcs0: SUCCESS (0.027s)
[149.685871] Starting dynamic subtest: bcs0
[149.691371] Dynamic subtest bcs0: SUCCESS (0.027s)
[149.713729] Starting dynamic subtest: vcs0
[149.716653] Dynamic subtest vcs0: SUCCESS (0.026s)
[149.738171] Starting dynamic subtest: vecs0
[149.748396] Dynamic subtest vecs0: SUCCESS (0.030s)
[149.750272] Subtest basic-busy: SUCCESS (0.113s)
[150.534510] [022/165] (938s left) gem_exec_fence (basic-wait)
[150.962803] Starting subtest: basic-wait
[150.966380] Starting dynamic subtest: rcs0
[150.986501] Dynamic subtest rcs0: SUCCESS (0.025s)
[151.022405] Starting dynamic subtest: bcs0
[151.024811] Dynamic subtest bcs0: SUCCESS (0.030s)
[151.061718] Starting dynamic subtest: vcs0
[151.065660] Dynamic subtest vcs0: SUCCESS (0.028s)
[151.085832] Starting dynamic subtest: vecs0
[151.087344] Dynamic subtest vecs0: SUCCESS (0.026s)
[151.088838] Subtest basic-wait: SUCCESS (0.115s)
[151.718141] [023/165] (937s left) gem_exec_fence (basic-await)
[152.146161] Starting subtest: basic-await
[152.147615] Starting dynamic subtest: rcs0
[152.329528] Dynamic subtest rcs0: SUCCESS (0.178s)
[152.347902] Starting dynamic subtest: bcs0
[152.496250] Dynamic subtest bcs0: SUCCESS (0.170s)
[152.514765] Starting dynamic subtest: vcs0
[152.671371] Dynamic subtest vcs0: SUCCESS (0.175s)
[152.691197] Starting dynamic subtest: vecs0
[152.852690] Dynamic subtest vecs0: SUCCESS (0.182s)
[152.854370] Subtest basic-await: SUCCESS (0.709s)
[153.518279] [024/165] (935s left) gem_exec_fence (nb-await)
[153.948819] Starting subtest: nb-await
[153.951244] Starting dynamic subtest: rcs0
[154.029607] Dynamic subtest rcs0: SUCCESS (0.084s)
[154.055741] Starting dynamic subtest: bcs0
[154.118148] Dynamic subtest bcs0: SUCCESS (0.081s)
[154.141686] Starting dynamic subtest: vcs0
[154.188103] Dynamic subtest vcs0: SUCCESS (0.074s)
[154.214668] Starting dynamic subtest: vecs0
[154.265799] Dynamic subtest vecs0: SUCCESS (0.079s)
[154.267290] Subtest nb-await: SUCCESS (0.320s)
[154.919832] [025/165] (934s left) gem_exec_gttfill (basic)
[155.191362] Starting subtest: basic
[157.055455] Subtest basic: SKIP (1.853s)
[157.309952] [026/165] (931s left) gem_exec_parallel (engines)
[157.740175] Starting subtest: engines
[157.741624] Starting dynamic subtest: basic
[163.384154] Dynamic subtest basic: SUCCESS (5.646s)
[163.407988] Starting dynamic subtest: contexts
[171.786994] Dynamic subtest contexts: SUCCESS (8.399s)
[171.817419] Starting dynamic subtest: fds
[183.984094] Dynamic subtest fds: SUCCESS (12.196s)
[184.007935] Starting dynamic subtest: userptr
[189.894056] Dynamic subtest userptr: SUCCESS (5.913s)
[189.895684] Subtest engines: SUCCESS (32.159s)
[190.159594] [027/165] (899s left) gem_exec_store (basic)
[190.432363] Starting subtest: basic
[190.507966] Subtest basic: SUCCESS (0.078s)
[190.755510] [028/165] (898s left) gem_flink_basic (bad-flink)
[190.987625] Starting subtest: bad-flink
[190.991243] Subtest bad-flink: SUCCESS (0.000s)
[191.104304] [029/165] (898s left) gem_flink_basic (bad-open)
[191.331600] Starting subtest: bad-open
[191.334688] Subtest bad-open: SUCCESS (0.000s)
[191.437485] [030/165] (898s left) gem_flink_basic (basic)
[191.662890] Starting subtest: basic
[191.664844] Subtest basic: SUCCESS (0.000s)
[191.769951] [031/165] (897s left) gem_flink_basic (double-flink)
[191.993510] Starting subtest: double-flink
[191.996594] Subtest double-flink: SUCCESS (0.000s)
[192.103558] [032/165] (897s left) gem_flink_basic (flink-lifetime)
[192.332299] Starting subtest: flink-lifetime
[192.337123] Subtest flink-lifetime: SUCCESS (0.006s)
[192.453982] [033/165] (897s left) gem_huc_copy (huc-copy)
[192.689809] Subtest huc-copy: SKIP (0.000s)
[192.762797] [034/165] (896s left) gem_linear_blits (basic)
[193.312632] Subtest basic: SKIP (0.000s)
[193.439656] [035/165] (896s left) gem_mmap (basic)
[193.828882] Starting subtest: basic
[193.840765] Subtest basic: SUCCESS (0.001s)
[193.937169] [036/165] (895s left) gem_mmap_gtt (basic)
[194.171818] Starting subtest: basic
[194.173649] Subtest basic: SUCCESS (0.003s)
[194.275221] [037/165] (895s left) gem_render_linear_blits (basic)
[194.520125] Starting subtest: basic
[194.639130] Subtest basic: SUCCESS (0.112s)
[194.708972] [038/165] (895s left) gem_render_tiled_blits (basic)
[194.946181] Starting subtest: basic
[195.082220] Subtest basic: SUCCESS (0.129s)
[195.161113] [039/165] (894s left) gem_ringfill (basic-all)
[195.580610] Starting subtest: basic-all
[196.932053] Subtest basic-all: SUCCESS (1.346s)
[197.036137] [040/165] (893s left) gem_softpin (allocator-basic)
[197.282075] Starting subtest: allocator-basic
[197.579784] Subtest allocator-basic: SUCCESS (0.297s)
[197.752436] [041/165] (892s left) gem_softpin (allocator-basic-reserve)
[197.994587] Starting subtest: allocator-basic-reserve
[198.291209] Subtest allocator-basic-reserve: SUCCESS (0.293s)
[198.469499] [042/165] (891s left) gem_softpin (safe-alignment)
[198.720162] Starting subtest: safe-alignment
[198.765158] Subtest safe-alignment: SUCCESS (0.043s)
[198.884363] [043/165] (891s left) gem_sync (basic-all)
[199.205391] Starting subtest: basic-all
[201.926561] Subtest basic-all: SUCCESS (2.723s)
[202.169391] [044/165] (888s left) gem_sync (basic-each)
[202.443977] Starting subtest: basic-each
[205.512195] Subtest basic-each: SUCCESS (3.070s)
[205.763148] [045/165] (884s left) gem_tiled_blits (basic)
[206.287647] Subtest basic: SKIP (0.000s)
[206.378298] [046/165] (884s left) gem_tiled_fence_blits (basic)
[207.037464] Starting subtest: basic
[207.088636] Subtest basic: SUCCESS (0.053s)
[207.240150] [047/165] (883s left) gem_tiled_pread_basic
[208.453970] [048/165] (882s left) gem_wait (busy@all-engines)
[208.752422] Starting subtest: busy
[208.753945] Starting dynamic subtest: all-engines
[209.276231] Dynamic subtest all-engines: SUCCESS (0.528s)
[209.279047] Subtest busy: SUCCESS (0.531s)
[209.605064] [049/165] (880s left) gem_wait (wait@all-engines)
[209.899173] Starting subtest: wait
[209.900766] Starting dynamic subtest: all-engines
[210.939140] Dynamic subtest all-engines: SUCCESS (1.035s)
[210.941940] Subtest wait: SUCCESS (1.036s)
[211.244730] [050/165] (879s left) i915_getparams_basic (basic-eu-total)
[211.475146] Starting subtest: basic-eu-total
[211.480120] Subtest basic-eu-total: SUCCESS (0.000s)
[211.586302] [051/165] (879s left) i915_getparams_basic (basic-subslice-total)
[211.811618] Starting subtest: basic-subslice-total
[211.817666] Subtest basic-subslice-total: SUCCESS (0.000s)
[211.923192] [052/165] (878s left) i915_hangman (error-state-basic)
[212.185076] Starting subtest: error-state-basic
[212.218663] Subtest error-state-basic: SUCCESS (0.036s)
[212.353338] [053/165] (878s left) i915_pciid
[212.683978] [054/165] (878s left) kms_addfb_basic (addfb25-4-tiled)
[213.352798] Starting subtest: addfb25-4-tiled
[213.356645] Subtest addfb25-4-tiled: SUCCESS (0.004s)
[213.470912] [055/165] (877s left) kms_addfb_basic (addfb25-bad-modifier)
[213.703092] Starting subtest: addfb25-bad-modifier
[213.706870] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[214.237088] [056/165] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[214.459339] Starting subtest: addfb25-framebuffer-vs-set-tiling
[214.465139] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[214.987870] [057/165] (876s left) kms_addfb_basic (addfb25-modifier-no-flag)
[215.217253] Starting subtest: addfb25-modifier-no-flag
[215.221519] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[215.769637] [058/165] (875s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[215.998098] Starting subtest: addfb25-x-tiled-legacy
[216.000282] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[216.583334] [059/165] (874s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[216.813230] Starting subtest: addfb25-x-tiled-mismatch-legacy
[216.817554] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[217.403927] [060/165] (873s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[218.060440] Starting subtest: addfb25-yf-tiled-legacy
[218.064152] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[218.170582] [061/165] (873s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[218.841077] Starting subtest: addfb25-y-tiled-legacy
[218.845213] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[218.951687] [062/165] (872s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[219.651819] Starting subtest: addfb25-y-tiled-small-legacy
[219.658678] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[219.757192] [063/165] (871s left) kms_addfb_basic (bad-pitch-0)
[219.981257] Starting subtest: bad-pitch-0
[219.984128] Subtest bad-pitch-0: SUCCESS (0.000s)
[220.519603] [064/165] (870s left) kms_addfb_basic (bad-pitch-1024)
[220.749217] Starting subtest: bad-pitch-1024
[220.750765] Subtest bad-pitch-1024: SUCCESS (0.000s)
[221.286131] [065/165] (870s left) kms_addfb_basic (bad-pitch-128)
[221.511481] Starting subtest: bad-pitch-128
[221.513897] Subtest bad-pitch-128: SUCCESS (0.000s)
[222.053464] [066/165] (869s left) kms_addfb_basic (bad-pitch-256)
[222.289157] Starting subtest: bad-pitch-256
[222.290579] Subtest bad-pitch-256: SUCCESS (0.000s)
[222.802573] [067/165] (868s left) kms_addfb_basic (bad-pitch-32)
[223.036486] Starting subtest: bad-pitch-32
[223.040561] Subtest bad-pitch-32: SUCCESS (0.000s)
[223.585884] [068/165] (868s left) kms_addfb_basic (bad-pitch-63)
[223.815513] Starting subtest: bad-pitch-63
[223.817357] Subtest bad-pitch-63: SUCCESS (0.000s)
[224.356130] [069/165] (867s left) kms_addfb_basic (bad-pitch-65536)
[224.592962] Starting subtest: bad-pitch-65536
[224.594588] Subtest bad-pitch-65536: SUCCESS (0.001s)
[225.119641] [070/165] (866s left) kms_addfb_basic (bad-pitch-999)
[225.349404] Starting subtest: bad-pitch-999
[225.351861] Subtest bad-pitch-999: SUCCESS (0.000s)
[225.887375] [071/165] (865s left) kms_addfb_basic (basic)
[226.119057] Starting subtest: basic
[226.120568] Subtest basic: SUCCESS (0.000s)
[226.653037] [072/165] (865s left) kms_addfb_basic (basic-x-tiled-legacy)
[226.889845] Starting subtest: basic-x-tiled-legacy
[226.894086] Subtest basic-x-tiled-legacy: SUCCESS (0.002s)
[227.420431] [073/165] (864s left) kms_addfb_basic (basic-y-tiled-legacy)
[227.648451] Starting subtest: basic-y-tiled-legacy
[227.651538] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[228.187731] [074/165] (863s left) kms_addfb_basic (bo-too-small)
[228.870387] Starting subtest: bo-too-small
[228.873573] Subtest bo-too-small: SUCCESS (0.002s)
[228.985691] [075/165] (863s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[229.643300] Starting subtest: bo-too-small-due-to-tiling
[229.644870] Subtest bo-too-small-due-to-tiling: SUCCESS (0.003s)
[229.753735] [076/165] (862s left) kms_addfb_basic (clobberred-modifier)
[229.983283] Starting subtest: clobberred-modifier
[229.986108] Subtest clobberred-modifier: SUCCESS (0.000s)
[230.536500] [077/165] (861s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[230.762570] Starting subtest: framebuffer-vs-set-tiling
[230.766528] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[231.287315] [078/165] (860s left) kms_addfb_basic (invalid-get-prop)
[231.522595] Starting subtest: invalid-get-prop
[231.524247] Subtest invalid-get-prop: SUCCESS (0.000s)
[232.090084] [079/165] (860s left) kms_addfb_basic (invalid-get-prop-any)
[232.322201] Starting subtest: invalid-get-prop-any
[232.323695] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[232.853639] [080/165] (859s left) kms_addfb_basic (invalid-set-prop)
[233.087794] Starting subtest: invalid-set-prop
[233.089454] Subtest invalid-set-prop: SUCCESS (0.000s)
[233.636525] [081/165] (858s left) kms_addfb_basic (invalid-set-prop-any)
[233.866048] Starting subtest: invalid-set-prop-any
[233.867895] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[234.406837] [082/165] (857s left) kms_addfb_basic (no-handle)
[234.629911] Starting subtest: no-handle
[234.634515] Subtest no-handle: SUCCESS (0.000s)
[235.171211] [083/165] (857s left) kms_addfb_basic (size-max)
[235.828149] Starting subtest: size-max
[235.831310] Subtest size-max: SUCCESS (0.000s)
[235.937209] [084/165] (856s left) kms_addfb_basic (small-bo)
[236.584817] Starting subtest: small-bo
[236.587206] Subtest small-bo: SUCCESS (0.000s)
[236.706308] [085/165] (855s left) kms_addfb_basic (tile-pitch-mismatch)
[236.941531] Starting subtest: tile-pitch-mismatch
[236.943346] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[237.486969] [086/165] (855s left) kms_addfb_basic (too-high)
[238.122488] Starting subtest: too-high
[238.133655] Subtest too-high: SUCCESS (0.005s)
[238.252814] [087/165] (854s left) kms_addfb_basic (too-wide)
[238.910456] Starting subtest: too-wide
[238.912681] Subtest too-wide: SUCCESS (0.000s)
[239.026636] [088/165] (853s left) kms_addfb_basic (unused-handle)
[239.262163] Starting subtest: unused-handle
[239.264868] Subtest unused-handle: SUCCESS (0.000s)
[239.788635] [089/165] (852s left) kms_addfb_basic (unused-modifier)
[240.021575] Starting subtest: unused-modifier
[240.024223] Subtest unused-modifier: SUCCESS (0.000s)
[240.553343] [090/165] (852s left) kms_addfb_basic (unused-offsets)
[240.778333] Starting subtest: unused-offsets
[240.781539] Subtest unused-offsets: SUCCESS (0.000s)
[241.319980] [091/165] (851s left) kms_addfb_basic (unused-pitches)
[241.544520] Starting subtest: unused-pitches
[241.546522] Subtest unused-pitches: SUCCESS (0.000s)
[242.103787] [092/165] (850s left) kms_busy (basic)
[242.763088] Starting subtest: basic
[242.766617] Starting dynamic subtest: flip
[243.875580] Dynamic subtest flip: SUCCESS (1.115s)
[243.907541] Starting dynamic subtest: modeset
[246.122988] Dynamic subtest modeset: SUCCESS (2.242s)
[246.124927] Subtest basic: SUCCESS (3.364s)
[246.714725] [093/165] (846s left) kms_prop_blob (basic)
[246.951815] Starting subtest: basic
[246.955474] Subtest basic: SUCCESS (0.001s)
[247.077642] [094/165] (845s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[247.743832] Starting subtest: basic-busy-flip-before-cursor-atomic
[248.976156] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.227s)
[249.475243] [095/165] (843s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[250.154525] Starting subtest: basic-busy-flip-before-cursor-legacy
[251.389959] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.236s)
[251.859739] [096/165] (841s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[252.545884] Starting subtest: basic-flip-after-cursor-atomic
[253.745476] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.195s)
[254.273409] [097/165] (838s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[254.972120] Starting subtest: basic-flip-after-cursor-legacy
[256.212088] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.239s)
[256.710485] [098/165] (836s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[257.399173] Starting subtest: basic-flip-after-cursor-varying-size
[258.571656] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.173s)
[259.099587] [099/165] (834s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[259.783630] Starting subtest: basic-flip-before-cursor-atomic
[260.958491] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.182s)
[261.442805] [100/165] (831s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[262.105892] Starting subtest: basic-flip-before-cursor-legacy
[263.288306] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.181s)
[263.801666] [101/165] (829s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[264.498535] Starting subtest: basic-flip-before-cursor-varying-size
[265.680755] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.190s)
[266.189940] [102/165] (827s left) kms_dsc (dsc-basic)
[266.911401] Subtest dsc-basic: SKIP (0.000s)
[266.991186] [103/165] (826s left) kms_flip (basic-flip-vs-dpms)
[267.452249] Starting subtest: basic-flip-vs-dpms
[267.467569] Starting dynamic subtest: C-HDMI-A2
[270.279159] Dynamic subtest C-HDMI-A2: SUCCESS (2.805s)
[270.288058] Subtest basic-flip-vs-dpms: SUCCESS (2.830s)
[270.773868] [104/165] (822s left) kms_flip (basic-flip-vs-modeset)
[271.238564] Starting subtest: basic-flip-vs-modeset
[271.253395] Starting dynamic subtest: C-HDMI-A2
[274.126819] Dynamic subtest C-HDMI-A2: SUCCESS (2.857s)
[274.131667] Subtest basic-flip-vs-modeset: SUCCESS (2.879s)
[274.834427] [105/165] (818s left) kms_flip (basic-flip-vs-wf_vblank)
[275.322852] Starting subtest: basic-flip-vs-wf_vblank
[275.343249] Starting dynamic subtest: C-HDMI-A2
[278.435702] Dynamic subtest C-HDMI-A2: SUCCESS (3.088s)
[278.439043] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.118s)
[278.620954] [106/165] (815s left) kms_flip (basic-plain-flip)
[279.088882] Starting subtest: basic-plain-flip
[279.103158] Starting dynamic subtest: C-HDMI-A2
[281.699620] Dynamic subtest C-HDMI-A2: SUCCESS (2.589s)
[281.704049] Subtest basic-plain-flip: SUCCESS (2.618s)
[281.870994] [107/165] (811s left) kms_force_connector_basic (force-connector-state)
[282.225958] Starting subtest: force-connector-state
[283.123112] Subtest force-connector-state: SUCCESS (0.901s)
[284.447482] [108/165] (809s left) kms_force_connector_basic (force-edid)
[284.804312] Starting subtest: force-edid
[284.906196] Subtest force-edid: SUCCESS (0.100s)
[285.697588] [109/165] (808s left) kms_force_connector_basic (force-load-detect)
[286.087376] Starting subtest: force-load-detect
[286.090842] Subtest force-load-detect: SKIP (0.000s)
[286.630222] [110/165] (807s left) kms_force_connector_basic (prune-stale-modes)
[287.001685] Starting subtest: prune-stale-modes
[287.122924] Subtest prune-stale-modes: SUCCESS (0.118s)
[287.911739] [111/165] (806s left) kms_frontbuffer_tracking (basic)
[288.681804] Starting subtest: basic
[292.874279] Subtest basic: SUCCESS (4.192s)
[293.012346] [112/165] (801s left) kms_hdmi_inject (inject-audio)
[293.348946] Starting subtest: inject-audio
[293.904111] Subtest inject-audio: FAIL (0.499s)
[294.844590] [113/165] (799s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[295.605946] Starting subtest: compare-crc-sanitycheck-xr24
[295.620307] Starting dynamic subtest: pipe-C-HDMI-A-2
[296.170677] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.540s)
[296.180061] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.554s)
[296.720826] [114/165] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[297.399764] Starting subtest: compare-crc-sanitycheck-nv12
[297.414302] Starting dynamic subtest: pipe-C-HDMI-A-2
[297.418786] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[297.425910] Subtest compare-crc-sanitycheck-nv12: SKIP (0.022s)
[297.537871] [115/165] (796s left) kms_pipe_crc_basic (hang-read-crc)
[298.248239] Starting subtest: hang-read-crc
[298.253348] Starting dynamic subtest: pipe-C-HDMI-A-2
[299.888835] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.643s)
[299.894429] Subtest hang-read-crc: SUCCESS (1.652s)
[300.443261] [116/165] (793s left) kms_pipe_crc_basic (nonblocking-crc)
[301.161297] Starting subtest: nonblocking-crc
[301.165290] Starting dynamic subtest: pipe-C-HDMI-A-2
[301.897622] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.737s)
[301.907957] Subtest nonblocking-crc: SUCCESS (0.748s)
[302.412186] [117/165] (791s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[303.128181] Starting subtest: nonblocking-crc-frame-sequence
[303.131368] Starting dynamic subtest: pipe-C-HDMI-A-2
[303.842820] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.708s)
[303.845353] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.718s)
[304.340132] [118/165] (790s left) kms_pipe_crc_basic (read-crc)
[305.017154] Starting subtest: read-crc
[305.021505] Starting dynamic subtest: pipe-C-HDMI-A-2
[305.663860] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.640s)
[305.665222] Subtest read-crc: SUCCESS (0.653s)
[306.176761] [119/165] (788s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[306.869868] Starting subtest: read-crc-frame-sequence
[306.878974] Starting dynamic subtest: pipe-C-HDMI-A-2
[307.488308] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.607s)
[307.489908] Subtest read-crc-frame-sequence: SUCCESS (0.621s)
[307.959105] [120/165] (786s left) kms_pm_backlight (basic-brightness)
[308.645245] Subtest basic-brightness: SKIP (0.000s)
[308.714576] [121/165] (785s left) kms_pm_rpm (basic-pci-d3-state)
[311.079170] Starting subtest: basic-pci-d3-state
[311.405306] Subtest basic-pci-d3-state: SUCCESS (0.326s)
[311.728620] [122/165] (782s left) kms_pm_rpm (basic-rte)
[311.957583] Starting subtest: basic-rte
[314.383997] Subtest basic-rte: SUCCESS (2.421s)
[315.487187] [123/165] (779s left) kms_psr (primary_page_flip)
[315.734638] Subtest primary_page_flip: SKIP (0.000s)
[315.812518] [124/165] (778s left) kms_psr (cursor_plane_move)
[316.041357] Subtest cursor_plane_move: SKIP (0.000s)
[316.138881] [125/165] (778s left) kms_psr (sprite_plane_onoff)
[316.368639] Subtest sprite_plane_onoff: SKIP (0.000s)
[316.444571] [126/165] (778s left) kms_psr (primary_mmap_gtt)
[316.677453] Subtest primary_mmap_gtt: SKIP (0.000s)
[316.742813] [127/165] (778s left) kms_setmode (basic-clone-single-crtc)
[316.982451] Starting subtest: basic-clone-single-crtc
[316.987250] Subtest basic-clone-single-crtc: SKIP (0.001s)
[317.092997] [128/165] (777s left) i915_pm_rps (basic-api)
[317.355758] Starting subtest: basic-api
[317.365272] Subtest basic-api: SUCCESS (0.014s)
[317.489931] [129/165] (777s left) prime_self_import (basic-llseek-bad)
[317.715543] Starting subtest: basic-llseek-bad
[317.721566] Subtest basic-llseek-bad: SUCCESS (0.008s)
[317.838735] [130/165] (777s left) prime_self_import (basic-llseek-size)
[318.059662] Starting subtest: basic-llseek-size
[318.084270] Subtest basic-llseek-size: SUCCESS (0.023s)
[318.212392] [131/165] (776s left) prime_self_import (basic-with_fd_dup)
[318.436109] Starting subtest: basic-with_fd_dup
[318.450744] Subtest basic-with_fd_dup: SUCCESS (0.014s)
[318.569968] [132/165] (776s left) prime_self_import (basic-with_one_bo)
[318.787842] Starting subtest: basic-with_one_bo
[318.801915] Subtest basic-with_one_bo: SUCCESS (0.014s)
[318.914761] [133/165] (776s left) prime_self_import (basic-with_one_bo_two_files)
[319.143435] Starting subtest: basic-with_one_bo_two_files
[319.148337] Subtest basic-with_one_bo_two_files: SUCCESS (0.010s)
[319.257408] [134/165] (776s left) prime_self_import (basic-with_two_bos)
[319.484113] Starting subtest: basic-with_two_bos
[319.486935] Subtest basic-with_two_bos: SUCCESS (0.012s)
[319.609372] [135/165] (775s left) prime_vgem (basic-fence-flip)
[319.879286] Starting subtest: basic-fence-flip
[320.709085] Subtest basic-fence-flip: SKIP (0.817s)
[320.871675] [136/165] (774s left) prime_vgem (basic-fence-mmap)
[321.141514] Starting subtest: basic-fence-mmap
[321.255536] Subtest basic-fence-mmap: SUCCESS (0.111s)
[321.378682] [137/165] (774s left) prime_vgem (basic-fence-read)
[321.636231] Starting subtest: basic-fence-read
[321.819367] Subtest basic-fence-read: SUCCESS (0.181s)
[321.948791] [138/165] (773s left) prime_vgem (basic-gtt)
[322.230515] Starting subtest: basic-gtt
[322.275984] Subtest basic-gtt: SUCCESS (0.049s)
[322.409582] [139/165] (773s left) prime_vgem (basic-read)
[322.679216] Starting subtest: basic-read
[322.761438] Subtest basic-read: SUCCESS (0.080s)
[322.890997] [140/165] (772s left) prime_vgem (basic-write)
[323.152791] Starting subtest: basic-write
[323.251857] Subtest basic-write: SUCCESS (0.097s)
[323.376333] [141/165] (772s left) vgem_basic (setversion)
[323.615903] Starting subtest: setversion
[323.618647] Subtest setversion: SUCCESS (0.000s)
[323.708357] [142/165] (772s left) vgem_basic (create)
[323.949922] Starting subtest: create
[323.952543] Subtest create: SUCCESS (0.001s)
[324.041283] [143/165] (771s left) vgem_basic (debugfs)
[324.282029] Starting subtest: debugfs
[324.283601] Subtest debugfs: SUCCESS (0.002s)
[324.387323] [144/165] (771s left) vgem_basic (dmabuf-export)
[324.637753] Starting subtest: dmabuf-export
[324.641121] Subtest dmabuf-export: SUCCESS (0.007s)
[324.754835] [145/165] (771s left) vgem_basic (dmabuf-fence)
[325.002807] Starting subtest: dmabuf-fence
[325.004661] Subtest dmabuf-fence: SUCCESS (0.002s)
[325.109650] [146/165] (771s left) vgem_basic (dmabuf-fence-before)
[325.354205] Starting subtest: dmabuf-fence-before
[325.355662] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[325.459647] [147/165] (770s left) vgem_basic (dmabuf-mmap)
[325.695757] Starting subtest: dmabuf-mmap
[325.746483] Subtest dmabuf-mmap: SUCCESS (0.049s)
[325.834841] [148/165] (770s left) vgem_basic (mmap)
[326.084831] Starting subtest: mmap
[326.115155] Subtest mmap: SUCCESS (0.031s)
[326.201444] [149/165] (770s left) vgem_basic (second-client)
[326.430672] Starting subtest: second-client
[326.465202] Subtest second-client: SUCCESS (0.032s)
[326.551616] [150/165] (769s left) vgem_basic (sysfs)
[326.799961] Starting subtest: sysfs
[326.802651] Subtest sysfs: SUCCESS (0.002s)
[326.904617] [151/165] (769s left) core_hotunplug (unbind-rebind)
[327.231224] Starting subtest: unbind-rebind
[332.009134] Subtest unbind-rebind: SUCCESS (4.770s)
[332.085410] [152/165] (764s left) vgem_basic (unload)
[332.363697] Starting subtest: unload
[361.573796] Subtest unload: SUCCESS (29.204s)
[361.779320] [153/165] (734s left) i915_module_load (reload)
[362.005424] Starting subtest: reload
[366.864125] Subtest reload: SUCCESS (4.851s)
[367.073111] [154/165] (729s left) gem_lmem_swapping (basic)
[367.547081] Subtest basic: SKIP (0.000s)
[367.676703] [155/165] (729s left) gem_lmem_swapping (parallel-random-engines)
[367.945695] Subtest parallel-random-engines: SKIP (0.000s)
[368.019143] [156/165] (728s left) gem_lmem_swapping (random-engines)
[368.258172] Subtest random-engines: SKIP (0.000s)
[368.338994] [157/165] (728s left) gem_lmem_swapping (verify-random)
[368.581110] Subtest verify-random: SKIP (0.000s)
[368.654463] [158/165] (728s left) i915_pm_rpm (module-reload)
[371.353140] Starting subtest: module-reload
[383.685829] Subtest module-reload: SUCCESS (12.341s)
[383.742520] [159/165] (713s left) i915_selftest (live)
[383.996780] Starting subtest: live
[383.999286] Starting dynamic subtest: sanitycheck
[385.796608] Dynamic subtest sanitycheck: SUCCESS (1.794s)
[385.817989] Starting dynamic subtest: uncore
[387.597422] Dynamic subtest uncore: SUCCESS (1.797s)
[387.616360] Starting dynamic subtest: workarounds
[389.670288] Dynamic subtest workarounds: SUCCESS (2.067s)
[389.688806] Starting dynamic subtest: gt_engines
[392.060456] Dynamic subtest gt_engines: SUCCESS (2.387s)
[392.079121] Starting dynamic subtest: gt_timelines
[421.162207] Dynamic subtest gt_timelines: SUCCESS (29.098s)
[421.180966] Starting dynamic subtest: gt_contexts
[423.138047] Dynamic subtest gt_contexts: SUCCESS (1.973s)
[423.156941] Starting dynamic subtest: gt_lrc
[428.303536] Dynamic subtest gt_lrc: SUCCESS (5.159s)
[428.322702] Starting dynamic subtest: gt_mocs
[430.115414] Dynamic subtest gt_mocs: SUCCESS (1.809s)
[430.134969] Starting dynamic subtest: gt_pm
[433.005690] Dynamic subtest gt_pm: SUCCESS (2.884s)
[433.024330] Starting dynamic subtest: gt_heartbeat
[434.997461] Dynamic subtest gt_heartbeat: SUCCESS (1.988s)
[435.016204] Starting dynamic subtest: gt_tlb
[437.211958] Dynamic subtest gt_tlb: SUCCESS (2.209s)
[437.230848] Starting dynamic subtest: requests
[445.595642] Dynamic subtest requests: SUCCESS (8.380s)
[445.615853] Starting dynamic subtest: migrate
[450.931383] Dynamic subtest migrate: SUCCESS (5.328s)
[450.954714] Starting dynamic subtest: active
[452.820309] Dynamic subtest active: SUCCESS (1.886s)
[452.853954] Starting dynamic subtest: objects
[456.698913] Dynamic subtest objects: SUCCESS (3.871s)
[456.717957] Starting dynamic subtest: mman
[466.814142] Dynamic subtest mman: SUCCESS (10.112s)
[466.833135] Starting dynamic subtest: dmabuf
[468.789481] Dynamic subtest dmabuf: SUCCESS (1.970s)
[468.808840] Starting dynamic subtest: vma
[470.738461] Dynamic subtest vma: SUCCESS (1.944s)
[470.759459] Starting dynamic subtest: coherency
[478.292285] Dynamic subtest coherency: SUCCESS (7.549s)
[478.314424] Starting dynamic subtest: gtt
[487.788063] Dynamic subtest gtt: SUCCESS (9.493s)
[487.808081] Starting dynamic subtest: gem
[490.601448] Dynamic subtest gem: SUCCESS (2.811s)
[490.624611] Starting dynamic subtest: evict
[498.761102] Dynamic subtest evict: SUCCESS (8.150s)
[498.780923] Starting dynamic subtest: hugepages
[501.036366] Dynamic subtest hugepages: SUCCESS (2.270s)
[501.055648] Starting dynamic subtest: gem_contexts
[525.468138] Dynamic subtest gem_contexts: SUCCESS (24.425s)
[525.490502] Starting dynamic subtest: client
[527.425511] Dynamic subtest client: SUCCESS (1.955s)
[527.449939] Starting dynamic subtest: gem_migrate
[529.252217] Dynamic subtest gem_migrate: SUCCESS (1.816s)
[529.271575] Starting dynamic subtest: reset
[538.640640] Dynamic subtest reset: SUCCESS (9.385s)
[538.660569] Starting dynamic subtest: memory_region
[540.391096] Dynamic subtest memory_region: SUCCESS (1.743s)
[540.458191] Starting dynamic subtest: hangcheck
[565.463141] Dynamic subtest hangcheck: SUCCESS (25.073s)
[565.482633] Starting dynamic subtest: execlists
[577.218439] Dynamic subtest execlists: SUCCESS (11.749s)
[577.237675] Starting dynamic subtest: ring_submission
[579.077416] Dynamic subtest ring_submission: SUCCESS (1.856s)
[579.101594] Starting dynamic subtest: perf
[581.235832] Dynamic subtest perf: SUCCESS (2.150s)
[581.256645] Starting dynamic subtest: slpc
[583.050870] Dynamic subtest slpc: SUCCESS (1.813s)
[583.070684] Starting dynamic subtest: guc
[584.770704] Dynamic subtest guc: SUCCESS (1.714s)
[584.790257] Starting dynamic subtest: guc_multi_lrc
[586.576156] Dynamic subtest guc_multi_lrc: SUCCESS (1.800s)
[586.595461] Starting dynamic subtest: guc_hang
[588.456578] Dynamic subtest guc_hang: SUCCESS (1.874s)
[588.514130] Starting dynamic subtest: late_gt_pm
[590.354631] Dynamic subtest late_gt_pm: SUCCESS (1.887s)
[590.356082] Subtest live: SUCCESS (206.358s)
[590.412739] [160/165] (506s left) dmabuf (all-tests)
[590.654432] Starting subtest: all-tests
[590.656196] Starting dynamic subtest: sanitycheck
[590.716450] Dynamic subtest sanitycheck: SUCCESS (0.065s)
[590.776084] Starting dynamic subtest: dma_fence
[590.909358] Dynamic subtest dma_fence: SUCCESS (0.186s)
[590.962500] Starting dynamic subtest: dma_fence_chain
[621.879320] Dynamic subtest dma_fence_chain: SUCCESS (30.957s)
[621.920306] Starting dynamic subtest: dma_fence_unwrap
[621.948739] Dynamic subtest dma_fence_unwrap: SUCCESS (0.071s)
[621.990473] Starting dynamic subtest: dma_resv
[622.018304] Dynamic subtest dma_resv: SUCCESS (0.059s)
[622.019792] Subtest all-tests: SUCCESS (31.372s)
[622.077765] [161/165] (475s left) i915_suspend (basic-s2idle-without-i915)
[622.303194] Starting subtest: basic-s2idle-without-i915
[644.991812] Subtest basic-s2idle-without-i915: SUCCESS (8.672s)
[650.747317] [162/165] (465s left) i915_suspend (basic-s3-without-i915)
[650.985086] Starting subtest: basic-s3-without-i915
[672.831176] Subtest basic-s3-without-i915: SUCCESS (6.961s)
[676.605944] [163/165] (457s left) gem_exec_suspend (basic-s0)
[676.900700] Starting subtest: basic-S0
[676.902232] Starting dynamic subtest: smem
[700.525046] Dynamic subtest smem: SUCCESS (8.355s)
[700.526449] Subtest basic-S0: SUCCESS (8.360s)
[706.762474] [164/165] (449s left) gem_exec_suspend (basic-s3)
[707.036667] Starting subtest: basic-S3
[707.040322] Starting dynamic subtest: smem
[731.201152] Dynamic subtest smem: SUCCESS (9.288s)
[731.203149] Subtest basic-S3: SUCCESS (9.292s)
[734.418156] [165/165] (439s left) kms_pipe_crc_basic (suspend-read-crc)
[735.121102] Starting subtest: suspend-read-crc
[735.126096] Starting dynamic subtest: pipe-C-HDMI-A-2
[756.129949] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.366s)
[756.139330] Subtest suspend-read-crc: SUCCESS (5.381s)
[760.476002] Closing watchdogs
Done.