[52.855668] Initializing watchdogs
[52.855968]   /dev/watchdog0
[52.875323] [001/165] (960s left) i915_module_load (load)
[53.130375] Starting subtest: load
[57.082250] Subtest load: SUCCESS (3.951s)
[57.134214] [002/165] (956s left) core_auth (basic-auth)
[57.496150] Starting subtest: basic-auth
[57.503739] Subtest basic-auth: SUCCESS (0.009s)
[57.693295] [003/165] (955s left) debugfs_test (read_all_entries)
[58.031936] Starting subtest: read_all_entries
[58.203578] Subtest read_all_entries: SUCCESS (0.169s)
[58.776494] [004/165] (954s left) debugfs_test (basic-hwmon)
[59.018580] Starting subtest: basic-hwmon
[59.022595] Subtest basic-hwmon: SKIP (0.000s)
[59.576379] [005/165] (954s left) fbdev (eof)
[59.818430] Starting subtest: eof
[59.822405] Subtest eof: SUCCESS (0.002s)
[59.941783] [006/165] (953s left) fbdev (info)
[60.171533] Starting subtest: info
[60.173255] Subtest info: SUCCESS (0.000s)
[60.342155] [007/165] (953s left) fbdev (nullptr)
[60.581124] Starting subtest: nullptr
[60.582885] Subtest nullptr: SUCCESS (0.001s)
[60.710463] [008/165] (953s left) fbdev (read)
[60.948991] Starting subtest: read
[69.396640] Subtest read: SUCCESS (8.450s)
[69.539822] [009/165] (944s left) fbdev (write)
[69.781622] Starting subtest: write
[74.126395] Subtest write: SUCCESS (4.339s)
[74.281264] [010/165] (939s left) gem_basic (bad-close)
[74.511357] Starting subtest: bad-close
[74.515649] Subtest bad-close: SUCCESS (0.000s)
[74.679501] [011/165] (939s left) gem_basic (create-close)
[74.909270] Starting subtest: create-close
[74.914301] Subtest create-close: SUCCESS (0.001s)
[75.074672] [012/165] (938s left) gem_basic (create-fd-close)
[75.298818] Starting subtest: create-fd-close
[75.305406] Subtest create-fd-close: SUCCESS (0.000s)
[75.441689] [013/165] (938s left) gem_busy (busy@all-engines)
[75.715739] Starting subtest: busy
[75.717731] Starting dynamic subtest: all-engines
[75.880401] Dynamic subtest all-engines: SUCCESS (0.165s)
[75.881936] Subtest busy: SUCCESS (0.168s)
[76.354419] [014/165] (937s left) gem_close_race (basic-process)
[76.637389] Starting subtest: basic-process
[76.771521] Subtest basic-process: SUCCESS (0.137s)
[77.045288] [015/165] (937s left) gem_close_race (basic-threads)
[77.320891] Starting subtest: basic-threads
[78.565672] Subtest basic-threads: SUCCESS (1.244s)
[78.844464] [016/165] (935s left) gem_ctx_create (basic)
[79.117703] Starting subtest: basic
[79.119641] Subtest basic: SUCCESS (0.000s)
[79.419080] [017/165] (934s left) gem_ctx_create (basic-files)
[79.687691] Starting subtest: basic-files
[81.758693] Subtest basic-files: SUCCESS (2.067s)
[82.078974] [018/165] (932s left) gem_ctx_exec (basic)
[82.326768] Starting subtest: basic
[82.339911] Subtest basic: SUCCESS (0.013s)
[82.508910] [019/165] (931s left) gem_exec_basic (basic)
[82.764255] Starting subtest: basic
[82.766314] Starting dynamic subtest: rcs0-smem
[82.767958] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[82.789754] Starting dynamic subtest: bcs0-smem
[82.791408] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[82.811251] Starting dynamic subtest: vcs0-smem
[82.814485] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[82.833981] Starting dynamic subtest: vecs0-smem
[82.835769] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[82.837238] Subtest basic: SUCCESS (0.016s)
[83.088133] [020/165] (931s left) gem_exec_create (basic)
[83.354313] Starting subtest: basic
[83.356178] Starting dynamic subtest: smem
[85.434479] Dynamic subtest smem: SUCCESS (2.084s)
[85.437624] Subtest basic: SUCCESS (2.085s)
[85.711849] [021/165] (928s left) gem_exec_fence (basic-busy)
[86.137163] Starting subtest: basic-busy
[86.142320] Starting dynamic subtest: rcs0
[86.162448] Dynamic subtest rcs0: SUCCESS (0.023s)
[86.194935] Starting dynamic subtest: bcs0
[86.201133] Dynamic subtest bcs0: SUCCESS (0.029s)
[86.233131] Starting dynamic subtest: vcs0
[86.239757] Dynamic subtest vcs0: SUCCESS (0.024s)
[86.258425] Starting dynamic subtest: vecs0
[86.261540] Dynamic subtest vecs0: SUCCESS (0.028s)
[86.263055] Subtest basic-busy: SUCCESS (0.107s)
[87.087885] [022/165] (927s left) gem_exec_fence (basic-wait)
[87.518655] Starting subtest: basic-wait
[87.520738] Starting dynamic subtest: rcs0
[87.540999] Dynamic subtest rcs0: SUCCESS (0.024s)
[87.568689] Starting dynamic subtest: bcs0
[87.572185] Dynamic subtest bcs0: SUCCESS (0.025s)
[87.612212] Starting dynamic subtest: vcs0
[87.613727] Dynamic subtest vcs0: SUCCESS (0.021s)
[87.631474] Starting dynamic subtest: vecs0
[87.633024] Dynamic subtest vecs0: SUCCESS (0.019s)
[87.634598] Subtest basic-wait: SUCCESS (0.093s)
[88.312365] [023/165] (926s left) gem_exec_fence (basic-await)
[88.743061] Starting subtest: basic-await
[88.746058] Starting dynamic subtest: rcs0
[88.937697] Dynamic subtest rcs0: SUCCESS (0.195s)
[88.963686] Starting dynamic subtest: bcs0
[89.113762] Dynamic subtest bcs0: SUCCESS (0.177s)
[89.138751] Starting dynamic subtest: vcs0
[89.298222] Dynamic subtest vcs0: SUCCESS (0.181s)
[89.322758] Starting dynamic subtest: vecs0
[89.479093] Dynamic subtest vecs0: SUCCESS (0.179s)
[89.480996] Subtest basic-await: SUCCESS (0.737s)
[90.209306] [024/165] (924s left) gem_exec_fence (nb-await)
[90.627485] Starting subtest: nb-await
[90.632141] Starting dynamic subtest: rcs0
[90.711790] Dynamic subtest rcs0: SUCCESS (0.083s)
[90.741279] Starting dynamic subtest: bcs0
[90.793324] Dynamic subtest bcs0: SUCCESS (0.076s)
[90.821069] Starting dynamic subtest: vcs0
[90.867415] Dynamic subtest vcs0: SUCCESS (0.075s)
[90.894120] Starting dynamic subtest: vecs0
[90.948840] Dynamic subtest vecs0: SUCCESS (0.081s)
[90.950676] Subtest nb-await: SUCCESS (0.322s)
[91.679231] [025/165] (922s left) gem_exec_gttfill (basic)
[91.952265] Starting subtest: basic
[95.998340] Subtest basic: SKIP (4.027s)
[96.333382] [026/165] (918s left) gem_exec_parallel (engines)
[96.725703] Starting subtest: engines
[96.727626] Starting dynamic subtest: basic
[101.525880] Dynamic subtest basic: SUCCESS (4.807s)
[101.548720] Starting dynamic subtest: contexts
[109.606701] Dynamic subtest contexts: SUCCESS (8.077s)
[109.637288] Starting dynamic subtest: fds
[122.192315] Dynamic subtest fds: SUCCESS (12.587s)
[122.216800] Starting dynamic subtest: userptr
[127.787673] Dynamic subtest userptr: SUCCESS (5.594s)
[127.789437] Subtest engines: SUCCESS (31.070s)
[128.115469] [027/165] (886s left) gem_exec_store (basic)
[128.398544] Starting subtest: basic
[128.464388] Subtest basic: SUCCESS (0.071s)
[128.748522] [028/165] (886s left) gem_flink_basic (bad-flink)
[128.977107] Starting subtest: bad-flink
[128.980534] Subtest bad-flink: SUCCESS (0.001s)
[129.145929] [029/165] (885s left) gem_flink_basic (bad-open)
[129.366105] Starting subtest: bad-open
[129.369380] Subtest bad-open: SUCCESS (0.000s)
[129.513728] [030/165] (885s left) gem_flink_basic (basic)
[129.737139] Starting subtest: basic
[129.740237] Subtest basic: SUCCESS (0.000s)
[129.917107] [031/165] (885s left) gem_flink_basic (double-flink)
[130.144746] Starting subtest: double-flink
[130.147498] Subtest double-flink: SUCCESS (0.001s)
[130.316351] [032/165] (884s left) gem_flink_basic (flink-lifetime)
[130.542069] Starting subtest: flink-lifetime
[130.549477] Subtest flink-lifetime: SUCCESS (0.007s)
[130.717816] [033/165] (884s left) gem_huc_copy (huc-copy)
[130.953564] Subtest huc-copy: SKIP (0.000s)
[131.037644] [034/165] (884s left) gem_linear_blits (basic)
[132.869325] Subtest basic: SKIP (0.000s)
[133.056122] [035/165] (882s left) gem_mmap (basic)
[133.417305] Starting subtest: basic
[133.430373] Subtest basic: SUCCESS (0.005s)
[133.581975] [036/165] (881s left) gem_mmap_gtt (basic)
[133.815219] Starting subtest: basic
[133.817881] Subtest basic: SUCCESS (0.004s)
[133.976588] [037/165] (881s left) gem_render_linear_blits (basic)
[134.221839] Starting subtest: basic
[134.343647] Subtest basic: SUCCESS (0.112s)
[134.441778] [038/165] (880s left) gem_render_tiled_blits (basic)
[134.682234] Starting subtest: basic
[134.809325] Subtest basic: SUCCESS (0.119s)
[134.911272] [039/165] (880s left) gem_ringfill (basic-all)
[135.355163] Starting subtest: basic-all
[136.645265] Subtest basic-all: SUCCESS (1.293s)
[136.816601] [040/165] (878s left) gem_softpin (allocator-basic)
[137.064030] Starting subtest: allocator-basic
[137.360133] Subtest allocator-basic: SUCCESS (0.289s)
[137.584828] [041/165] (877s left) gem_softpin (allocator-basic-reserve)
[137.820728] Starting subtest: allocator-basic-reserve
[138.117462] Subtest allocator-basic-reserve: SUCCESS (0.289s)
[138.347329] [042/165] (877s left) gem_softpin (safe-alignment)
[138.595625] Starting subtest: safe-alignment
[138.639059] Subtest safe-alignment: SUCCESS (0.041s)
[138.810927] [043/165] (876s left) gem_sync (basic-all)
[139.082433] Starting subtest: basic-all
[141.800737] Subtest basic-all: SUCCESS (2.717s)
[142.084452] [044/165] (873s left) gem_sync (basic-each)
[142.362676] Starting subtest: basic-each
[144.967593] Subtest basic-each: SUCCESS (2.608s)
[145.249663] [045/165] (870s left) gem_tiled_blits (basic)
[147.288249] Subtest basic: SKIP (0.000s)
[147.410222] [046/165] (868s left) gem_tiled_fence_blits (basic)
[149.318166] Starting subtest: basic
[149.370110] Subtest basic: SUCCESS (0.055s)
[149.585429] [047/165] (866s left) gem_tiled_pread_basic
[150.853295] [048/165] (865s left) gem_wait (busy@all-engines)
[151.156171] Starting subtest: busy
[151.161604] Starting dynamic subtest: all-engines
[151.694172] Dynamic subtest all-engines: SUCCESS (0.536s)
[151.695621] Subtest busy: SUCCESS (0.537s)
[152.047257] [049/165] (863s left) gem_wait (wait@all-engines)
[152.336218] Starting subtest: wait
[152.338247] Starting dynamic subtest: all-engines
[153.384056] Dynamic subtest all-engines: SUCCESS (1.049s)
[153.388094] Subtest wait: SUCCESS (1.049s)
[153.753981] [050/165] (862s left) i915_getparams_basic (basic-eu-total)
[153.986139] Starting subtest: basic-eu-total
[153.991966] Subtest basic-eu-total: SUCCESS (0.000s)
[154.151515] [051/165] (861s left) i915_getparams_basic (basic-subslice-total)
[154.378560] Starting subtest: basic-subslice-total
[154.383968] Subtest basic-subslice-total: SUCCESS (0.000s)
[154.544211] [052/165] (861s left) i915_hangman (error-state-basic)
[154.805658] Starting subtest: error-state-basic
[154.845093] Subtest error-state-basic: SUCCESS (0.038s)
[155.047870] [053/165] (861s left) i915_pciid
[155.455255] [054/165] (860s left) kms_addfb_basic (addfb25-4-tiled)
[156.123913] Starting subtest: addfb25-4-tiled
[156.125931] Subtest addfb25-4-tiled: SUCCESS (0.003s)
[156.280613] [055/165] (860s left) kms_addfb_basic (addfb25-bad-modifier)
[156.517383] Starting subtest: addfb25-bad-modifier
[156.522149] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[157.118639] [056/165] (859s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[157.356577] Starting subtest: addfb25-framebuffer-vs-set-tiling
[157.359255] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[157.952176] [057/165] (858s left) kms_addfb_basic (addfb25-modifier-no-flag)
[158.180853] Starting subtest: addfb25-modifier-no-flag
[158.183931] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[158.791659] [058/165] (857s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[159.025605] Starting subtest: addfb25-x-tiled-legacy
[159.029518] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[159.617401] [059/165] (856s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[159.847198] Starting subtest: addfb25-x-tiled-mismatch-legacy
[159.849999] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[160.413269] [060/165] (856s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[161.057765] Starting subtest: addfb25-yf-tiled-legacy
[161.060748] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[161.219246] [061/165] (855s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[161.847689] Starting subtest: addfb25-y-tiled-legacy
[161.849885] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[162.015141] [062/165] (854s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[162.643878] Starting subtest: addfb25-y-tiled-small-legacy
[162.650148] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[162.820229] [063/165] (853s left) kms_addfb_basic (bad-pitch-0)
[163.042289] Starting subtest: bad-pitch-0
[163.045299] Subtest bad-pitch-0: SUCCESS (0.000s)
[163.615804] [064/165] (853s left) kms_addfb_basic (bad-pitch-1024)
[163.848143] Starting subtest: bad-pitch-1024
[163.851929] Subtest bad-pitch-1024: SUCCESS (0.000s)
[164.454185] [065/165] (852s left) kms_addfb_basic (bad-pitch-128)
[164.684893] Starting subtest: bad-pitch-128
[164.688270] Subtest bad-pitch-128: SUCCESS (0.000s)
[165.289911] [066/165] (851s left) kms_addfb_basic (bad-pitch-256)
[165.529069] Starting subtest: bad-pitch-256
[165.530761] Subtest bad-pitch-256: SUCCESS (0.000s)
[166.123324] [067/165] (850s left) kms_addfb_basic (bad-pitch-32)
[166.355671] Starting subtest: bad-pitch-32
[166.360692] Subtest bad-pitch-32: SUCCESS (0.000s)
[166.949130] [068/165] (850s left) kms_addfb_basic (bad-pitch-63)
[167.182052] Starting subtest: bad-pitch-63
[167.184032] Subtest bad-pitch-63: SUCCESS (0.000s)
[167.785935] [069/165] (849s left) kms_addfb_basic (bad-pitch-65536)
[168.017885] Starting subtest: bad-pitch-65536
[168.022601] Subtest bad-pitch-65536: SUCCESS (0.001s)
[168.581794] [070/165] (848s left) kms_addfb_basic (bad-pitch-999)
[168.807351] Starting subtest: bad-pitch-999
[168.810780] Subtest bad-pitch-999: SUCCESS (0.000s)
[169.413093] [071/165] (847s left) kms_addfb_basic (basic)
[169.646109] Starting subtest: basic
[169.648367] Subtest basic: SUCCESS (0.000s)
[170.252719] [072/165] (847s left) kms_addfb_basic (basic-x-tiled-legacy)
[170.487156] Starting subtest: basic-x-tiled-legacy
[170.488799] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[171.049157] [073/165] (846s left) kms_addfb_basic (basic-y-tiled-legacy)
[171.287673] Starting subtest: basic-y-tiled-legacy
[171.289975] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[171.848320] [074/165] (845s left) kms_addfb_basic (bo-too-small)
[172.485294] Starting subtest: bo-too-small
[172.489445] Subtest bo-too-small: SUCCESS (0.001s)
[172.649156] [075/165] (844s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[173.296112] Starting subtest: bo-too-small-due-to-tiling
[173.298562] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[173.492969] [076/165] (843s left) kms_addfb_basic (clobberred-modifier)
[173.724915] Starting subtest: clobberred-modifier
[173.727264] Subtest clobberred-modifier: SUCCESS (0.000s)
[174.286532] [077/165] (843s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[174.525246] Starting subtest: framebuffer-vs-set-tiling
[174.527648] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[175.089339] [078/165] (842s left) kms_addfb_basic (invalid-get-prop)
[175.318856] Starting subtest: invalid-get-prop
[175.321346] Subtest invalid-get-prop: SUCCESS (0.000s)
[175.887247] [079/165] (841s left) kms_addfb_basic (invalid-get-prop-any)
[176.115688] Starting subtest: invalid-get-prop-any
[176.117397] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[176.681600] [080/165] (841s left) kms_addfb_basic (invalid-set-prop)
[176.908093] Starting subtest: invalid-set-prop
[176.909689] Subtest invalid-set-prop: SUCCESS (0.000s)
[177.514256] [081/165] (840s left) kms_addfb_basic (invalid-set-prop-any)
[177.744080] Starting subtest: invalid-set-prop-any
[177.745645] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[178.315180] [082/165] (839s left) kms_addfb_basic (no-handle)
[178.544180] Starting subtest: no-handle
[178.546560] Subtest no-handle: SUCCESS (0.000s)
[179.148331] [083/165] (838s left) kms_addfb_basic (size-max)
[179.796427] Starting subtest: size-max
[179.798708] Subtest size-max: SUCCESS (0.000s)
[179.985390] [084/165] (837s left) kms_addfb_basic (small-bo)
[180.640120] Starting subtest: small-bo
[180.643775] Subtest small-bo: SUCCESS (0.000s)
[180.822429] [085/165] (837s left) kms_addfb_basic (tile-pitch-mismatch)
[181.056403] Starting subtest: tile-pitch-mismatch
[181.058759] Subtest tile-pitch-mismatch: SUCCESS (0.003s)
[181.651623] [086/165] (836s left) kms_addfb_basic (too-high)
[182.308528] Starting subtest: too-high
[182.313908] Subtest too-high: SUCCESS (0.006s)
[182.481209] [087/165] (835s left) kms_addfb_basic (too-wide)
[183.120238] Starting subtest: too-wide
[183.122449] Subtest too-wide: SUCCESS (0.000s)
[183.284773] [088/165] (834s left) kms_addfb_basic (unused-handle)
[183.509279] Starting subtest: unused-handle
[183.510997] Subtest unused-handle: SUCCESS (0.000s)
[184.081629] [089/165] (834s left) kms_addfb_basic (unused-modifier)
[184.314666] Starting subtest: unused-modifier
[184.317168] Subtest unused-modifier: SUCCESS (0.000s)
[184.922138] [090/165] (833s left) kms_addfb_basic (unused-offsets)
[185.151658] Starting subtest: unused-offsets
[185.153364] Subtest unused-offsets: SUCCESS (0.000s)
[185.746564] [091/165] (832s left) kms_addfb_basic (unused-pitches)
[185.980363] Starting subtest: unused-pitches
[185.983365] Subtest unused-pitches: SUCCESS (0.000s)
[186.582330] [092/165] (831s left) kms_busy (basic)
[187.287552] Starting subtest: basic
[187.301728] Starting dynamic subtest: flip
[188.871755] Dynamic subtest flip: SUCCESS (1.576s)
[188.922386] Starting dynamic subtest: modeset
[191.782109] Dynamic subtest modeset: SUCCESS (2.900s)
[191.795095] Subtest basic: SUCCESS (4.489s)
[192.447824] [093/165] (825s left) kms_prop_blob (basic)
[192.682315] Starting subtest: basic
[192.686622] Subtest basic: SUCCESS (0.000s)
[192.842808] [094/165] (825s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[193.486838] Starting subtest: basic-busy-flip-before-cursor-atomic
[195.738832] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (2.249s)
[196.317390] [095/165] (822s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[196.965357] Starting subtest: basic-busy-flip-before-cursor-legacy
[199.187823] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (2.227s)
[199.812986] [096/165] (818s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[200.457090] Starting subtest: basic-flip-after-cursor-atomic
[202.695383] Subtest basic-flip-after-cursor-atomic: SUCCESS (2.233s)
[203.296200] [097/165] (815s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[203.958105] Starting subtest: basic-flip-after-cursor-legacy
[206.241639] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.287s)
[206.853098] [098/165] (811s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[207.518110] Starting subtest: basic-flip-after-cursor-varying-size
[209.735289] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.216s)
[210.346366] [099/165] (808s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[211.019610] Starting subtest: basic-flip-before-cursor-atomic
[213.235053] Subtest basic-flip-before-cursor-atomic: SUCCESS (2.207s)
[213.842891] [100/165] (804s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[214.505418] Starting subtest: basic-flip-before-cursor-legacy
[216.722431] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.221s)
[217.340852] [101/165] (801s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[218.013561] Starting subtest: basic-flip-before-cursor-varying-size
[220.256140] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.241s)
[220.863669] [102/165] (798s left) kms_dsc (dsc-basic)
[221.587580] Subtest dsc-basic: SKIP (0.000s)
[221.681863] [103/165] (797s left) kms_flip (basic-flip-vs-dpms)
[222.137080] Starting subtest: basic-flip-vs-dpms
[222.150966] Starting dynamic subtest: C-HDMI-A2
[225.441118] Dynamic subtest C-HDMI-A2: SUCCESS (3.280s)
[225.442866] Subtest basic-flip-vs-dpms: SUCCESS (3.298s)
[226.042685] [104/165] (792s left) kms_flip (basic-flip-vs-modeset)
[226.507371] Starting subtest: basic-flip-vs-modeset
[226.513553] Starting dynamic subtest: C-HDMI-A2
[229.544995] Dynamic subtest C-HDMI-A2: SUCCESS (3.019s)
[229.562129] Subtest basic-flip-vs-modeset: SUCCESS (3.036s)
[230.298978] [105/165] (788s left) kms_flip (basic-flip-vs-wf_vblank)
[230.761430] Starting subtest: basic-flip-vs-wf_vblank
[230.773979] Starting dynamic subtest: C-HDMI-A2
[234.619514] Dynamic subtest C-HDMI-A2: SUCCESS (3.844s)
[234.627074] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.868s)
[234.862508] [106/165] (784s left) kms_flip (basic-plain-flip)
[235.348602] Starting subtest: basic-plain-flip
[235.367664] Starting dynamic subtest: C-HDMI-A2
[238.351105] Dynamic subtest C-HDMI-A2: SUCCESS (2.981s)
[238.352600] Subtest basic-plain-flip: SUCCESS (3.010s)
[238.590248] [107/165] (780s left) kms_force_connector_basic (force-connector-state)
[238.945655] Starting subtest: force-connector-state
[239.850526] Subtest force-connector-state: SUCCESS (0.902s)
[241.114889] [108/165] (778s left) kms_force_connector_basic (force-edid)
[241.457924] Starting subtest: force-edid
[241.548211] Subtest force-edid: SUCCESS (0.083s)
[242.373646] [109/165] (776s left) kms_force_connector_basic (force-load-detect)
[242.712401] Starting subtest: force-load-detect
[242.720124] Subtest force-load-detect: SKIP (0.000s)
[243.309715] [110/165] (776s left) kms_force_connector_basic (prune-stale-modes)
[243.671250] Starting subtest: prune-stale-modes
[243.776726] Subtest prune-stale-modes: SUCCESS (0.103s)
[244.607465] [111/165] (774s left) kms_frontbuffer_tracking (basic)
[245.304734] Starting subtest: basic
[250.607672] Subtest basic: FAIL (4.918s)
[250.645747] [112/165] (768s left) kms_hdmi_inject (inject-audio)
[251.060469] Starting subtest: inject-audio
[251.532056] Subtest inject-audio: FAIL (0.432s)
[252.569578] [113/165] (766s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[253.284591] Starting subtest: compare-crc-sanitycheck-xr24
[253.289066] Starting dynamic subtest: pipe-C-HDMI-A-2
[254.351794] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.065s)
[254.355710] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.077s)
[255.034466] [114/165] (764s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[255.734601] Starting subtest: compare-crc-sanitycheck-nv12
[255.740762] Starting dynamic subtest: pipe-C-HDMI-A-2
[255.745474] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[255.752140] Subtest compare-crc-sanitycheck-nv12: SKIP (0.015s)
[255.933765] [115/165] (763s left) kms_pipe_crc_basic (hang-read-crc)
[256.637644] Starting subtest: hang-read-crc
[256.641621] Starting dynamic subtest: pipe-C-HDMI-A-2
[259.450889] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.805s)
[259.452521] Subtest hang-read-crc: SUCCESS (2.815s)
[260.041819] [116/165] (759s left) kms_pipe_crc_basic (nonblocking-crc)
[260.730145] Starting subtest: nonblocking-crc
[260.733613] Starting dynamic subtest: pipe-C-HDMI-A-2
[262.121307] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.379s)
[262.123566] Subtest nonblocking-crc: SUCCESS (1.391s)
[262.672222] [117/165] (757s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[263.365329] Starting subtest: nonblocking-crc-frame-sequence
[263.370139] Starting dynamic subtest: pipe-C-HDMI-A-2
[264.715792] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.340s)
[264.719406] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.355s)
[265.245788] [118/165] (754s left) kms_pipe_crc_basic (read-crc)
[265.925910] Starting subtest: read-crc
[265.927566] Starting dynamic subtest: pipe-C-HDMI-A-2
[267.194726] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.266s)
[267.199937] Subtest read-crc: SUCCESS (1.274s)
[267.784111] [119/165] (752s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[268.493817] Starting subtest: read-crc-frame-sequence
[268.498661] Starting dynamic subtest: pipe-C-HDMI-A-2
[269.727222] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.224s)
[269.730359] Subtest read-crc-frame-sequence: SUCCESS (1.240s)
[270.323899] [120/165] (749s left) kms_pm_backlight (basic-brightness)
[271.004863] Subtest basic-brightness: SKIP (0.000s)
[271.106221] [121/165] (748s left) kms_psr (primary_page_flip)
[271.337946] Subtest primary_page_flip: SKIP (0.000s)
[271.441407] [122/165] (748s left) kms_psr (cursor_plane_move)
[271.675697] Subtest cursor_plane_move: SKIP (0.000s)
[271.780487] [123/165] (748s left) kms_psr (sprite_plane_onoff)
[272.009246] Subtest sprite_plane_onoff: SKIP (0.000s)
[272.113648] [124/165] (748s left) kms_psr (primary_mmap_gtt)
[272.343832] Subtest primary_mmap_gtt: SKIP (0.000s)
[272.439850] [125/165] (747s left) kms_setmode (basic-clone-single-crtc)
[272.670627] Starting subtest: basic-clone-single-crtc
[272.677256] Subtest basic-clone-single-crtc: SKIP (0.001s)
[272.848760] [126/165] (747s left) i915_pm_rpm (basic-pci-d3-state)
[275.372607] Starting subtest: basic-pci-d3-state
[275.792232] Subtest basic-pci-d3-state: SUCCESS (0.405s)
[276.181709] [127/165] (744s left) i915_pm_rpm (basic-rte)
[276.410479] Starting subtest: basic-rte
[279.017750] Subtest basic-rte: SUCCESS (2.598s)
[280.144670] [128/165] (740s left) i915_pm_rps (basic-api)
[280.393397] Starting subtest: basic-api
[280.411124] Subtest basic-api: SUCCESS (0.015s)
[280.579882] [129/165] (739s left) prime_self_import (basic-llseek-bad)
[280.800289] Starting subtest: basic-llseek-bad
[280.807481] Subtest basic-llseek-bad: SUCCESS (0.008s)
[280.975572] [130/165] (739s left) prime_self_import (basic-llseek-size)
[281.204484] Starting subtest: basic-llseek-size
[281.216574] Subtest basic-llseek-size: SUCCESS (0.012s)
[281.371211] [131/165] (739s left) prime_self_import (basic-with_fd_dup)
[281.602277] Starting subtest: basic-with_fd_dup
[281.614570] Subtest basic-with_fd_dup: SUCCESS (0.011s)
[281.770856] [132/165] (738s left) prime_self_import (basic-with_one_bo)
[281.992663] Starting subtest: basic-with_one_bo
[282.003785] Subtest basic-with_one_bo: SUCCESS (0.013s)
[282.164842] [133/165] (738s left) prime_self_import (basic-with_one_bo_two_files)
[282.388549] Starting subtest: basic-with_one_bo_two_files
[282.403181] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[282.576472] [134/165] (738s left) prime_self_import (basic-with_two_bos)
[282.791620] Starting subtest: basic-with_two_bos
[282.803566] Subtest basic-with_two_bos: SUCCESS (0.013s)
[282.967297] [135/165] (737s left) prime_vgem (basic-fence-flip)
[283.223253] Starting subtest: basic-fence-flip
[284.231136] Subtest basic-fence-flip: SKIP (0.994s)
[284.538174] [136/165] (736s left) prime_vgem (basic-fence-mmap)
[284.822588] Starting subtest: basic-fence-mmap
[284.925803] Subtest basic-fence-mmap: SUCCESS (0.103s)
[285.109494] [137/165] (735s left) prime_vgem (basic-fence-read)
[285.391697] Starting subtest: basic-fence-read
[285.570148] Subtest basic-fence-read: SUCCESS (0.181s)
[285.743994] [138/165] (735s left) prime_vgem (basic-gtt)
[286.031334] Starting subtest: basic-gtt
[286.075357] Subtest basic-gtt: SUCCESS (0.043s)
[286.273791] [139/165] (734s left) prime_vgem (basic-read)
[286.525686] Starting subtest: basic-read
[286.609064] Subtest basic-read: SUCCESS (0.080s)
[286.803721] [140/165] (734s left) prime_vgem (basic-write)
[287.097127] Starting subtest: basic-write
[287.191520] Subtest basic-write: SUCCESS (0.095s)
[287.373132] [141/165] (733s left) vgem_basic (setversion)
[287.636718] Starting subtest: setversion
[287.640920] Subtest setversion: SUCCESS (0.000s)
[287.771730] [142/165] (733s left) vgem_basic (create)
[288.001450] Starting subtest: create
[288.004214] Subtest create: SUCCESS (0.001s)
[288.148139] [143/165] (733s left) vgem_basic (debugfs)
[288.404728] Starting subtest: debugfs
[288.407916] Subtest debugfs: SUCCESS (0.002s)
[288.539215] [144/165] (732s left) vgem_basic (dmabuf-export)
[288.771903] Starting subtest: dmabuf-export
[288.777224] Subtest dmabuf-export: SUCCESS (0.010s)
[288.936970] [145/165] (732s left) vgem_basic (dmabuf-fence)
[289.169275] Starting subtest: dmabuf-fence
[289.172267] Subtest dmabuf-fence: SUCCESS (0.002s)
[289.307287] [146/165] (732s left) vgem_basic (dmabuf-fence-before)
[289.576289] Starting subtest: dmabuf-fence-before
[289.578330] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[289.709976] [147/165] (731s left) vgem_basic (dmabuf-mmap)
[289.972717] Starting subtest: dmabuf-mmap
[290.012157] Subtest dmabuf-mmap: SUCCESS (0.040s)
[290.136491] [148/165] (731s left) vgem_basic (mmap)
[290.402458] Starting subtest: mmap
[290.431153] Subtest mmap: SUCCESS (0.029s)
[290.580550] [149/165] (731s left) vgem_basic (second-client)
[290.836693] Starting subtest: second-client
[290.901874] Subtest second-client: SUCCESS (0.067s)
[291.039900] [150/165] (730s left) vgem_basic (sysfs)
[291.304156] Starting subtest: sysfs
[291.305938] Subtest sysfs: SUCCESS (0.002s)
[291.435932] [151/165] (730s left) core_hotunplug (unbind-rebind)
[291.767781] Starting subtest: unbind-rebind
[296.777671] Subtest unbind-rebind: SUCCESS (5.010s)
[296.868267] [152/165] (725s left) vgem_basic (unload)
[297.125103] Starting subtest: unload
[326.279363] Subtest unload: SUCCESS (29.154s)
[326.552619] [153/165] (695s left) i915_module_load (reload)
[326.783903] Starting subtest: reload
[331.723705] Subtest reload: SUCCESS (4.946s)
[331.885302] [154/165] (690s left) gem_lmem_swapping (basic)
[332.322130] Subtest basic: SKIP (0.000s)
[332.445605] [155/165] (689s left) gem_lmem_swapping (parallel-random-engines)
[332.698093] Subtest parallel-random-engines: SKIP (0.000s)
[332.789804] [156/165] (689s left) gem_lmem_swapping (random-engines)
[333.035154] Subtest random-engines: SKIP (0.000s)
[333.118728] [157/165] (689s left) gem_lmem_swapping (verify-random)
[333.379632] Subtest verify-random: SKIP (0.000s)
[333.489503] [158/165] (688s left) i915_pm_rpm (module-reload)
[336.377975] Starting subtest: module-reload
[352.110726] Subtest module-reload: SUCCESS (15.740s)
[352.168376] [159/165] (670s left) i915_selftest (live)
[352.428677] Starting subtest: live
[352.430608] Starting dynamic subtest: sanitycheck
[354.667490] Dynamic subtest sanitycheck: SUCCESS (2.239s)
[354.714218] Starting dynamic subtest: uncore
[356.519409] Dynamic subtest uncore: SUCCESS (1.843s)
[356.542306] Starting dynamic subtest: workarounds
[358.558789] Dynamic subtest workarounds: SUCCESS (2.035s)
[358.584255] Starting dynamic subtest: gt_engines
[360.754532] Dynamic subtest gt_engines: SUCCESS (2.187s)
[360.773287] Starting dynamic subtest: gt_timelines
[389.047703] Dynamic subtest gt_timelines: SUCCESS (28.289s)
[389.066347] Starting dynamic subtest: gt_contexts
[391.115996] Dynamic subtest gt_contexts: SUCCESS (2.065s)
[391.134661] Starting dynamic subtest: gt_lrc
[396.246216] Dynamic subtest gt_lrc: SUCCESS (5.126s)
[396.267261] Starting dynamic subtest: gt_mocs
[397.980430] Dynamic subtest gt_mocs: SUCCESS (1.730s)
[398.025681] Starting dynamic subtest: gt_pm
[400.904852] Dynamic subtest gt_pm: SUCCESS (2.914s)
[400.929247] Starting dynamic subtest: gt_heartbeat
[402.858116] Dynamic subtest gt_heartbeat: SUCCESS (1.947s)
[402.883648] Starting dynamic subtest: gt_tlb
[404.963477] Dynamic subtest gt_tlb: SUCCESS (2.097s)
[404.982889] Starting dynamic subtest: requests
[413.165175] Dynamic subtest requests: SUCCESS (8.201s)
[413.189230] Starting dynamic subtest: migrate
[418.361935] Dynamic subtest migrate: SUCCESS (5.189s)
[418.380793] Starting dynamic subtest: active
[420.155787] Dynamic subtest active: SUCCESS (1.792s)
[420.185389] Starting dynamic subtest: objects
[423.900672] Dynamic subtest objects: SUCCESS (3.735s)
[423.919673] Starting dynamic subtest: mman
[434.100875] Dynamic subtest mman: SUCCESS (10.198s)
[434.123545] Starting dynamic subtest: dmabuf
[435.993933] Dynamic subtest dmabuf: SUCCESS (1.888s)
[436.023270] Starting dynamic subtest: vma
[437.834109] Dynamic subtest vma: SUCCESS (1.833s)
[437.854902] Starting dynamic subtest: coherency
[443.331657] Dynamic subtest coherency: SUCCESS (5.494s)
[443.358540] Starting dynamic subtest: gtt
[452.671715] Dynamic subtest gtt: SUCCESS (9.332s)
[452.693792] Starting dynamic subtest: gem
[455.419335] Dynamic subtest gem: SUCCESS (2.747s)
[455.444566] Starting dynamic subtest: evict
[463.458270] Dynamic subtest evict: SUCCESS (8.032s)
[463.484483] Starting dynamic subtest: hugepages
[465.742825] Dynamic subtest hugepages: SUCCESS (2.276s)
[465.767142] Starting dynamic subtest: gem_contexts
[489.917165] Dynamic subtest gem_contexts: SUCCESS (24.169s)
[489.937933] Starting dynamic subtest: client
[491.644808] Dynamic subtest client: SUCCESS (1.724s)
[491.674085] Starting dynamic subtest: gem_migrate
[493.405702] Dynamic subtest gem_migrate: SUCCESS (1.755s)
[493.425750] Starting dynamic subtest: reset
[502.822499] Dynamic subtest reset: SUCCESS (9.415s)
[502.854799] Starting dynamic subtest: memory_region
[504.584695] Dynamic subtest memory_region: SUCCESS (1.746s)
[504.610398] Starting dynamic subtest: hangcheck
[529.625407] Dynamic subtest hangcheck: SUCCESS (25.039s)
[529.645210] Starting dynamic subtest: execlists
[541.168583] Dynamic subtest execlists: SUCCESS (11.539s)
[541.187899] Starting dynamic subtest: ring_submission
[543.028315] Dynamic subtest ring_submission: SUCCESS (1.857s)
[543.055888] Starting dynamic subtest: perf
[545.291340] Dynamic subtest perf: SUCCESS (2.257s)
[545.310471] Starting dynamic subtest: slpc
[547.082371] Dynamic subtest slpc: SUCCESS (1.789s)
[547.105370] Starting dynamic subtest: guc
[548.831116] Dynamic subtest guc: SUCCESS (1.743s)
[548.857894] Starting dynamic subtest: guc_multi_lrc
[550.582450] Dynamic subtest guc_multi_lrc: SUCCESS (1.748s)
[550.609687] Starting dynamic subtest: guc_hang
[552.416105] Dynamic subtest guc_hang: SUCCESS (1.825s)
[552.435644] Starting dynamic subtest: late_gt_pm
[554.305637] Dynamic subtest late_gt_pm: SUCCESS (1.885s)
[554.307328] Subtest live: SUCCESS (201.880s)
[554.371829] [160/165] (468s left) dmabuf (all-tests)
[554.611289] Starting subtest: all-tests
[554.613209] Starting dynamic subtest: sanitycheck
[554.677550] Dynamic subtest sanitycheck: SUCCESS (0.066s)
[554.734088] Starting dynamic subtest: dma_fence
[554.875963] Dynamic subtest dma_fence: SUCCESS (0.192s)
[554.906650] Starting dynamic subtest: dma_fence_chain
[585.273681] Dynamic subtest dma_fence_chain: SUCCESS (30.392s)
[585.321100] Starting dynamic subtest: dma_fence_unwrap
[585.346889] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s)
[585.389145] Starting dynamic subtest: dma_resv
[585.426089] Dynamic subtest dma_resv: SUCCESS (0.071s)
[585.435192] Subtest all-tests: SUCCESS (30.821s)
[585.491331] [161/165] (437s left) i915_suspend (basic-s2idle-without-i915)
[585.709297] Starting subtest: basic-s2idle-without-i915
[607.510748] Subtest basic-s2idle-without-i915: SUCCESS (7.781s)
[613.177008] [162/165] (428s left) i915_suspend (basic-s3-without-i915)
[613.427581] Starting subtest: basic-s3-without-i915
[634.392714] Subtest basic-s3-without-i915: SUCCESS (5.992s)
[636.264951] [163/165] (421s left) gem_exec_suspend (basic-s0)
[636.575058] Starting subtest: basic-S0
[636.576766] Starting dynamic subtest: smem
[659.326427] Dynamic subtest smem: SUCCESS (8.247s)
[659.329555] Subtest basic-S0: SUCCESS (8.251s)
[661.653580] [164/165] (412s left) gem_exec_suspend (basic-s3)
[661.929138] Starting subtest: basic-S3
[661.931812] Starting dynamic subtest: smem
[684.855928] Dynamic subtest smem: SUCCESS (7.959s)
[684.862389] Subtest basic-S3: SUCCESS (7.965s)
[686.163409] [165/165] (404s left) kms_pipe_crc_basic (suspend-read-crc)
[686.885152] Starting subtest: suspend-read-crc
[686.886774] Starting dynamic subtest: pipe-C-HDMI-A-2
[708.220521] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.501s)
[708.226702] Subtest suspend-read-crc: SUCCESS (5.513s)
[709.653866] Closing watchdogs
Done.