[44.822873] Initializing watchdogs
[44.823458]   /dev/watchdog0
[44.850148] [001/171] (960s left) i915_module_load (load)
[45.233275] Starting subtest: load
[48.337836] Subtest load: SUCCESS (3.106s)
[48.399735] [002/171] (957s left) core_auth (basic-auth)
[50.201852] Starting subtest: basic-auth
[50.208685] Subtest basic-auth: SUCCESS (0.003s)
[50.257442] [003/171] (955s left) debugfs_test (read_all_entries)
[50.665940] Starting subtest: read_all_entries
[51.804566] Subtest read_all_entries: SUCCESS (1.137s)
[51.982653] [004/171] (953s left) debugfs_test (basic-hwmon)
[52.383104] Starting subtest: basic-hwmon
[52.399497] Subtest basic-hwmon: SKIP (0.000s)
[52.559773] [005/171] (953s left) fbdev (eof)
[56.151581] Subtest eof: SKIP (0.000s)
[56.205484] [006/171] (949s left) fbdev (info)
[56.631437] Subtest info: SKIP (0.000s)
[56.685294] [007/171] (949s left) fbdev (nullptr)
[57.108103] Subtest nullptr: SKIP (0.000s)
[57.167161] [008/171] (948s left) fbdev (read)
[57.595934] Subtest read: SKIP (0.000s)
[57.650951] [009/171] (948s left) fbdev (write)
[58.086000] Subtest write: SKIP (0.000s)
[58.140765] [010/171] (947s left) gem_basic (bad-close)
[58.506853] Starting subtest: bad-close
[58.520579] Subtest bad-close: SUCCESS (0.000s)
[58.569954] [011/171] (947s left) gem_basic (create-close)
[58.945574] Starting subtest: create-close
[58.959324] Subtest create-close: SUCCESS (0.000s)
[59.026552] [012/171] (947s left) gem_basic (create-fd-close)
[59.404877] Starting subtest: create-fd-close
[59.418935] Subtest create-fd-close: SUCCESS (0.001s)
[59.482525] [013/171] (946s left) gem_busy (busy@all-engines)
[59.910348] Starting subtest: busy
[59.917330] Starting dynamic subtest: all-engines
[60.098313] Dynamic subtest all-engines: SUCCESS (0.187s)
[60.105332] Subtest busy: SUCCESS (0.188s)
[61.193360] [014/171] (945s left) gem_close_race (basic-process)
[61.637599] Starting subtest: basic-process
[61.741800] Subtest basic-process: SUCCESS (0.104s)
[61.934564] [015/171] (944s left) gem_close_race (basic-threads)
[62.368660] Starting subtest: basic-threads
[63.795518] Subtest basic-threads: SUCCESS (1.427s)
[63.979467] [016/171] (942s left) gem_ctx_create (basic)
[64.413725] Starting subtest: basic
[64.420762] Subtest basic: SUCCESS (0.000s)
[64.593236] [017/171] (941s left) gem_ctx_create (basic-files)
[65.011948] Starting subtest: basic-files
[67.082284] Subtest basic-files: SUCCESS (2.070s)
[68.180077] [018/171] (938s left) gem_ctx_exec (basic)
[68.578162] Starting subtest: basic
[68.592545] Subtest basic: SUCCESS (0.015s)
[68.693737] [019/171] (937s left) gem_exec_basic (basic)
[69.097973] Starting subtest: basic
[69.105617] Starting dynamic subtest: rcs0-smem
[69.112279] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[69.141964] Starting dynamic subtest: bcs0-smem
[69.148771] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[69.177579] Starting dynamic subtest: vcs0-smem
[69.184370] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[69.213383] Starting dynamic subtest: vcs1-smem
[69.220157] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[69.251915] Starting dynamic subtest: vecs0-smem
[69.258766] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[69.287782] Starting dynamic subtest: ccs0-smem
[69.294563] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[69.301256] Subtest basic: SUCCESS (0.019s)
[70.220866] [020/171] (936s left) gem_exec_create (basic)
[70.662954] Starting subtest: basic
[70.670579] Starting dynamic subtest: smem
[74.200406] Dynamic subtest smem: SUCCESS (3.532s)
[74.207671] Subtest basic: SUCCESS (3.534s)
[74.381919] [021/171] (932s left) gem_exec_fence (basic-busy)
[74.972889] Starting subtest: basic-busy
[74.982638] Starting dynamic subtest: rcs0
[75.064846] Dynamic subtest rcs0: SUCCESS (0.091s)
[75.095383] Starting dynamic subtest: bcs0
[75.118766] Dynamic subtest bcs0: SUCCESS (0.053s)
[75.153584] Starting dynamic subtest: vcs0
[75.171261] Dynamic subtest vcs0: SUCCESS (0.035s)
[75.205876] Starting dynamic subtest: vcs1
[75.220315] Dynamic subtest vcs1: SUCCESS (0.040s)
[75.254674] Starting dynamic subtest: vecs0
[75.268612] Dynamic subtest vecs0: SUCCESS (0.039s)
[75.298913] Starting dynamic subtest: ccs0
[75.316905] Dynamic subtest ccs0: SUCCESS (0.056s)
[75.323826] Subtest basic-busy: SUCCESS (0.319s)
[77.294335] [022/171] (929s left) gem_exec_fence (basic-wait)
[77.885653] Starting subtest: basic-wait
[77.893361] Starting dynamic subtest: rcs0
[77.952894] Dynamic subtest rcs0: SUCCESS (0.066s)
[77.991169] Starting dynamic subtest: bcs0
[78.021712] Dynamic subtest bcs0: SUCCESS (0.067s)
[78.052875] Starting dynamic subtest: vcs0
[78.060141] Dynamic subtest vcs0: SUCCESS (0.039s)
[78.093233] Starting dynamic subtest: vcs1
[78.100858] Dynamic subtest vcs1: SUCCESS (0.034s)
[78.129181] Starting dynamic subtest: vecs0
[78.136216] Dynamic subtest vecs0: SUCCESS (0.027s)
[78.167049] Starting dynamic subtest: ccs0
[78.183642] Dynamic subtest ccs0: SUCCESS (0.052s)
[78.190369] Subtest basic-wait: SUCCESS (0.290s)
[80.250108] [023/171] (926s left) gem_exec_fence (basic-await)
[80.834179] Starting subtest: basic-await
[80.841206] Starting dynamic subtest: rcs0
[81.078762] Dynamic subtest rcs0: SUCCESS (0.244s)
[81.114533] Starting dynamic subtest: bcs0
[81.291176] Dynamic subtest bcs0: SUCCESS (0.212s)
[81.324291] Starting dynamic subtest: vcs0
[81.506528] Dynamic subtest vcs0: SUCCESS (0.214s)
[81.531648] Starting dynamic subtest: vcs1
[81.701735] Dynamic subtest vcs1: SUCCESS (0.194s)
[81.732585] Starting dynamic subtest: vecs0
[81.916323] Dynamic subtest vecs0: SUCCESS (0.213s)
[81.947331] Starting dynamic subtest: ccs0
[82.131365] Dynamic subtest ccs0: SUCCESS (0.214s)
[82.138628] Subtest basic-await: SUCCESS (1.297s)
[84.280522] [024/171] (922s left) gem_exec_fence (nb-await)
[84.870699] Starting subtest: nb-await
[84.877744] Starting dynamic subtest: rcs0
[84.980307] Dynamic subtest rcs0: SUCCESS (0.107s)
[85.013777] Starting dynamic subtest: bcs0
[85.061302] Dynamic subtest bcs0: SUCCESS (0.083s)
[85.093204] Starting dynamic subtest: vcs0
[85.148521] Dynamic subtest vcs0: SUCCESS (0.084s)
[85.179736] Starting dynamic subtest: vcs1
[85.234468] Dynamic subtest vcs1: SUCCESS (0.084s)
[85.266553] Starting dynamic subtest: vecs0
[85.310861] Dynamic subtest vecs0: SUCCESS (0.078s)
[85.340902] Starting dynamic subtest: ccs0
[85.390469] Dynamic subtest ccs0: SUCCESS (0.079s)
[85.400520] Subtest nb-await: SUCCESS (0.520s)
[87.380651] [025/171] (919s left) gem_exec_gttfill (basic)
[87.822805] Starting subtest: basic
[98.691182] Subtest basic: SUCCESS (10.858s)
[98.877581] [026/171] (908s left) gem_exec_parallel (engines)
[99.416634] Starting subtest: engines
[99.425281] Starting dynamic subtest: basic
[104.088511] Dynamic subtest basic: SUCCESS (4.661s)
[104.126427] Starting dynamic subtest: contexts
[110.635309] Dynamic subtest contexts: SUCCESS (6.542s)
[110.672194] Starting dynamic subtest: fds
[116.639399] Dynamic subtest fds: SUCCESS (6.005s)
[116.673617] Starting dynamic subtest: userptr
[119.345651] Dynamic subtest userptr: SUCCESS (2.715s)
[119.352549] Subtest engines: SUCCESS (19.928s)
[119.611266] [027/171] (887s left) gem_exec_store (basic)
[120.059757] Starting subtest: basic
[121.159849] Subtest basic: SUCCESS (1.095s)
[121.349538] [028/171] (886s left) gem_flink_basic (bad-flink)
[121.726244] Starting subtest: bad-flink
[121.733658] Subtest bad-flink: SUCCESS (0.000s)
[121.794688] [029/171] (885s left) gem_flink_basic (bad-open)
[122.172957] Starting subtest: bad-open
[122.179831] Subtest bad-open: SUCCESS (0.000s)
[122.242744] [030/171] (885s left) gem_flink_basic (basic)
[122.618587] Starting subtest: basic
[122.625451] Subtest basic: SUCCESS (0.000s)
[122.703819] [031/171] (884s left) gem_flink_basic (double-flink)
[123.076750] Starting subtest: double-flink
[123.083537] Subtest double-flink: SUCCESS (0.000s)
[123.165262] [032/171] (884s left) gem_flink_basic (flink-lifetime)
[123.535427] Starting subtest: flink-lifetime
[123.542704] Subtest flink-lifetime: SUCCESS (0.008s)
[123.636887] [033/171] (884s left) gem_huc_copy (huc-copy)
[124.028448] Starting subtest: huc-copy
[124.043058] Subtest huc-copy: SUCCESS (0.013s)
[125.194740] [034/171] (882s left) gem_linear_blits (basic)
[125.986768] Starting subtest: basic
[126.004376] Subtest basic: SUCCESS (0.030s)
[126.140495] [035/171] (881s left) gem_mmap (basic)
[126.633933] Subtest basic: SKIP (0.000s)
[126.698061] [036/171] (881s left) gem_mmap_gtt (basic)
[127.085639] Subtest basic: SKIP (0.000s)
[127.142897] [037/171] (880s left) gem_render_linear_blits (basic)
[127.530908] Starting subtest: basic
[127.678244] Subtest basic: SUCCESS (0.147s)
[127.791814] [038/171] (880s left) gem_render_tiled_blits (basic)
[128.205592] Subtest basic: SKIP (0.000s)
[128.272549] [039/171] (880s left) gem_ringfill (basic-all)
[134.170900] Starting subtest: basic-all
[135.456663] Subtest basic-all: SUCCESS (1.290s)
[136.205534] [040/171] (872s left) gem_softpin (allocator-basic)
[136.608461] Starting subtest: allocator-basic
[137.147883] Subtest allocator-basic: SUCCESS (0.530s)
[137.317565] [041/171] (871s left) gem_softpin (allocator-basic-reserve)
[137.711608] Starting subtest: allocator-basic-reserve
[138.260316] Subtest allocator-basic-reserve: SUCCESS (0.539s)
[138.400239] [042/171] (870s left) gem_softpin (safe-alignment)
[138.818792] Starting subtest: safe-alignment
[138.902948] Subtest safe-alignment: SUCCESS (0.090s)
[140.233129] [043/171] (868s left) gem_sync (basic-all)
[140.677136] Starting subtest: basic-all
[144.136385] Subtest basic-all: SUCCESS (3.463s)
[144.331919] [044/171] (864s left) gem_sync (basic-each)
[144.763246] Starting subtest: basic-each
[148.169136] Subtest basic-each: SUCCESS (3.409s)
[148.372257] [045/171] (860s left) gem_tiled_blits (basic)
[148.774540] Subtest basic: SKIP (0.000s)
[148.840844] [046/171] (860s left) gem_tiled_fence_blits (basic)
[149.245723] Subtest basic: SKIP (0.000s)
[149.312778] [047/171] (859s left) gem_tiled_pread_basic
[149.748061] [048/171] (859s left) gem_wait (busy@all-engines)
[150.195732] Starting subtest: busy
[150.207204] Starting dynamic subtest: all-engines
[152.135259] Dynamic subtest all-engines: SUCCESS (1.933s)
[152.145294] Subtest busy: SUCCESS (1.934s)
[152.412569] [049/171] (856s left) gem_wait (wait@all-engines)
[152.869326] Starting subtest: wait
[152.876115] Starting dynamic subtest: all-engines
[154.185911] Dynamic subtest all-engines: SUCCESS (1.315s)
[154.192776] Subtest wait: SUCCESS (1.316s)
[154.450349] [050/171] (854s left) i915_getparams_basic (basic-eu-total)
[154.826450] Starting subtest: basic-eu-total
[154.839531] Subtest basic-eu-total: SUCCESS (0.000s)
[154.894775] [051/171] (854s left) i915_getparams_basic (basic-subslice-total)
[155.275116] Starting subtest: basic-subslice-total
[155.288279] Subtest basic-subslice-total: SUCCESS (0.000s)
[155.346676] [052/171] (854s left) i915_hangman (error-state-basic)
[155.777404] Starting subtest: error-state-basic
[156.915686] Subtest error-state-basic: SUCCESS (1.133s)
[157.006942] [053/171] (852s left) i915_pciid
[157.456710] [054/171] (852s left) kms_addfb_basic (addfb25-bad-modifier)
[157.826931] Starting subtest: addfb25-bad-modifier
[157.833807] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[158.061809] [055/171] (851s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[158.456764] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[158.668779] [056/171] (850s left) kms_addfb_basic (addfb25-modifier-no-flag)
[159.037689] Starting subtest: addfb25-modifier-no-flag
[159.044480] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[159.259230] [057/171] (850s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[159.636467] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[159.843453] [058/171] (849s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[160.226599] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[160.446406] [059/171] (849s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[160.963656] Starting subtest: addfb25-yf-tiled-legacy
[160.970493] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[161.054622] [060/171] (848s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[161.556851] Starting subtest: addfb25-y-tiled-legacy
[161.563655] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[161.657266] [061/171] (848s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[162.162146] Starting subtest: addfb25-y-tiled-small-legacy
[162.175667] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[162.270737] [062/171] (847s left) kms_addfb_basic (bad-pitch-0)
[162.651998] Starting subtest: bad-pitch-0
[162.658730] Subtest bad-pitch-0: SUCCESS (0.000s)
[162.881212] [063/171] (847s left) kms_addfb_basic (bad-pitch-1024)
[163.254814] Starting subtest: bad-pitch-1024
[163.261751] Subtest bad-pitch-1024: SUCCESS (0.000s)
[163.477749] [064/171] (846s left) kms_addfb_basic (bad-pitch-128)
[163.849975] Starting subtest: bad-pitch-128
[163.856822] Subtest bad-pitch-128: SUCCESS (0.000s)
[164.068654] [065/171] (846s left) kms_addfb_basic (bad-pitch-256)
[164.443804] Starting subtest: bad-pitch-256
[164.450709] Subtest bad-pitch-256: SUCCESS (0.000s)
[164.671960] [066/171] (845s left) kms_addfb_basic (bad-pitch-32)
[165.045654] Starting subtest: bad-pitch-32
[165.052688] Subtest bad-pitch-32: SUCCESS (0.000s)
[165.278065] [067/171] (845s left) kms_addfb_basic (bad-pitch-63)
[165.651337] Starting subtest: bad-pitch-63
[165.658143] Subtest bad-pitch-63: SUCCESS (0.000s)
[165.876533] [068/171] (844s left) kms_addfb_basic (bad-pitch-65536)
[166.248708] Starting subtest: bad-pitch-65536
[166.255571] Subtest bad-pitch-65536: SUCCESS (0.001s)
[166.470570] [069/171] (844s left) kms_addfb_basic (bad-pitch-999)
[166.845591] Starting subtest: bad-pitch-999
[166.852483] Subtest bad-pitch-999: SUCCESS (0.000s)
[167.075752] [070/171] (843s left) kms_addfb_basic (basic)
[167.453151] Starting subtest: basic
[167.459923] Subtest basic: SUCCESS (0.000s)
[167.683436] [071/171] (843s left) kms_addfb_basic (basic-x-tiled-legacy)
[168.071456] Starting subtest: basic-x-tiled-legacy
[168.089350] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[168.305266] [072/171] (842s left) kms_addfb_basic (basic-y-tiled-legacy)
[168.691223] Starting subtest: basic-y-tiled-legacy
[168.707799] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[168.908708] [073/171] (842s left) kms_addfb_basic (bo-too-small)
[169.408317] Starting subtest: bo-too-small
[169.415237] Subtest bo-too-small: SUCCESS (0.001s)
[169.524422] [074/171] (841s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[170.048131] Starting subtest: bo-too-small-due-to-tiling
[170.061272] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[170.168935] [075/171] (841s left) kms_addfb_basic (clobberred-modifier)
[170.544147] Starting subtest: clobberred-modifier
[170.557350] Subtest clobberred-modifier: SKIP (0.000s)
[170.787951] [076/171] (840s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[171.165541] Starting subtest: framebuffer-vs-set-tiling
[171.178516] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[171.403315] [077/171] (839s left) kms_addfb_basic (invalid-get-prop)
[171.778130] Starting subtest: invalid-get-prop
[171.784870] Subtest invalid-get-prop: SUCCESS (0.000s)
[172.010644] [078/171] (839s left) kms_addfb_basic (invalid-get-prop-any)
[172.386849] Starting subtest: invalid-get-prop-any
[172.394215] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[172.617646] [079/171] (838s left) kms_addfb_basic (invalid-set-prop)
[172.998229] Starting subtest: invalid-set-prop
[173.005111] Subtest invalid-set-prop: SUCCESS (0.000s)
[173.242581] [080/171] (838s left) kms_addfb_basic (invalid-set-prop-any)
[173.616380] Starting subtest: invalid-set-prop-any
[173.623839] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[173.858159] [081/171] (837s left) kms_addfb_basic (no-handle)
[174.237135] Starting subtest: no-handle
[174.243779] Subtest no-handle: SUCCESS (0.000s)
[174.475200] [082/171] (837s left) kms_addfb_basic (size-max)
[174.973940] Starting subtest: size-max
[174.980816] Subtest size-max: SUCCESS (0.001s)
[175.084364] [083/171] (836s left) kms_addfb_basic (small-bo)
[175.593687] Starting subtest: small-bo
[175.600643] Subtest small-bo: SUCCESS (0.000s)
[175.699167] [084/171] (836s left) kms_addfb_basic (tile-pitch-mismatch)
[176.074659] Starting subtest: tile-pitch-mismatch
[176.087928] Subtest tile-pitch-mismatch: SKIP (0.000s)
[176.300656] [085/171] (835s left) kms_addfb_basic (too-high)
[176.806913] Starting subtest: too-high
[176.813818] Subtest too-high: SUCCESS (0.004s)
[176.912634] [086/171] (835s left) kms_addfb_basic (too-wide)
[177.415622] Starting subtest: too-wide
[177.422685] Subtest too-wide: SUCCESS (0.000s)
[177.514425] [087/171] (834s left) kms_addfb_basic (unused-handle)
[177.887060] Starting subtest: unused-handle
[177.893881] Subtest unused-handle: SUCCESS (0.000s)
[178.108214] [088/171] (834s left) kms_addfb_basic (unused-modifier)
[178.478881] Starting subtest: unused-modifier
[178.485885] Subtest unused-modifier: SUCCESS (0.000s)
[178.711282] [089/171] (833s left) kms_addfb_basic (unused-offsets)
[179.080220] Starting subtest: unused-offsets
[179.087131] Subtest unused-offsets: SUCCESS (0.000s)
[179.320337] [090/171] (833s left) kms_addfb_basic (unused-pitches)
[179.695644] Starting subtest: unused-pitches
[179.702714] Subtest unused-pitches: SUCCESS (0.000s)
[179.933848] [091/171] (832s left) kms_busy (basic)
[180.479171] Subtest basic: SKIP (0.000s)
[180.552669] [092/171] (832s left) kms_chamelium_hpd (dp-hpd-fast)
[181.100999] Subtest dp-hpd-fast: SKIP (0.000s)
[181.174611] [093/171] (831s left) kms_chamelium_edid (dp-edid-read)
[181.708150] Subtest dp-edid-read: SKIP (0.000s)
[181.783361] [094/171] (831s left) kms_chamelium_frames (dp-crc-fast)
[182.335898] Subtest dp-crc-fast: SKIP (0.000s)
[182.403550] [095/171] (830s left) kms_chamelium_hpd (hdmi-hpd-fast)
[182.914122] Subtest hdmi-hpd-fast: SKIP (0.000s)
[182.979610] [096/171] (830s left) kms_chamelium_edid (hdmi-edid-read)
[183.400168] Subtest hdmi-edid-read: SKIP (0.000s)
[183.463554] [097/171] (829s left) kms_chamelium_frames (hdmi-crc-fast)
[183.980940] Subtest hdmi-crc-fast: SKIP (0.000s)
[184.049564] [098/171] (829s left) kms_chamelium_hpd (vga-hpd-fast)
[184.590417] Subtest vga-hpd-fast: SKIP (0.000s)
[184.660913] [099/171] (828s left) kms_chamelium_edid (vga-edid-read)
[185.182815] Subtest vga-edid-read: SKIP (0.000s)
[185.249556] [100/171] (828s left) kms_prop_blob (basic)
[185.622674] Starting subtest: basic
[185.629518] Subtest basic: SUCCESS (0.000s)
[185.694269] [101/171] (827s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[186.248136] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[186.313397] [102/171] (827s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[186.869694] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[186.937578] [103/171] (826s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[187.484176] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[187.548606] [104/171] (826s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[188.092358] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[188.156589] [105/171] (825s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[188.701973] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[188.771148] [106/171] (825s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[189.309155] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[189.373288] [107/171] (824s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[189.904658] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[189.971093] [108/171] (823s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[190.517495] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[190.583816] [109/171] (823s left) kms_flip (basic-flip-vs-dpms)
[190.990552] Starting subtest: basic-flip-vs-dpms
[191.015846] Subtest basic-flip-vs-dpms: SKIP (0.025s)
[191.137241] [110/171] (822s left) kms_flip (basic-flip-vs-modeset)
[191.550926] Starting subtest: basic-flip-vs-modeset
[191.576953] Subtest basic-flip-vs-modeset: SKIP (0.026s)
[191.699695] [111/171] (822s left) kms_flip (basic-flip-vs-wf_vblank)
[192.105658] Starting subtest: basic-flip-vs-wf_vblank
[192.132399] Subtest basic-flip-vs-wf_vblank: SKIP (0.026s)
[192.254080] [112/171] (822s left) kms_flip (basic-plain-flip)
[192.663833] Starting subtest: basic-plain-flip
[192.688429] Subtest basic-plain-flip: SKIP (0.024s)
[192.812125] [113/171] (821s left) kms_force_connector_basic (force-connector-state)
[193.207781] Starting subtest: force-connector-state
[195.353692] Subtest force-connector-state: SUCCESS (2.145s)
[195.885165] [114/171] (818s left) kms_force_connector_basic (force-edid)
[196.104552] Starting subtest: force-edid
[196.377346] Subtest force-edid: SUCCESS (0.267s)
[196.498164] [115/171] (818s left) kms_force_connector_basic (force-load-detect)
[196.889540] Starting subtest: force-load-detect
[196.904550] Subtest force-load-detect: SKIP (0.000s)
[197.080949] [116/171] (817s left) kms_force_connector_basic (prune-stale-modes)
[197.468791] Starting subtest: prune-stale-modes
[197.699726] Subtest prune-stale-modes: SKIP (0.220s)
[197.901308] [117/171] (816s left) kms_frontbuffer_tracking (basic)
[198.418967] Subtest basic: SKIP (0.000s)
[198.524998] [118/171] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[199.041934] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[199.140539] [119/171] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[199.643263] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[199.746517] [120/171] (815s left) kms_pipe_crc_basic (hang-read-crc)
[200.264280] Subtest hang-read-crc: SKIP (0.000s)
[200.360246] [121/171] (814s left) kms_pipe_crc_basic (nonblocking-crc)
[200.865172] Subtest nonblocking-crc: SKIP (0.000s)
[200.970556] [122/171] (814s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[201.495292] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[201.598240] [123/171] (813s left) kms_pipe_crc_basic (read-crc)
[202.115606] Subtest read-crc: SKIP (0.000s)
[202.215429] [124/171] (813s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[202.730554] Subtest read-crc-frame-sequence: SKIP (0.000s)
[202.833727] [125/171] (812s left) kms_psr (primary_page_flip)
[203.225796] Subtest primary_page_flip: SKIP (0.000s)
[203.316466] [126/171] (812s left) kms_psr (cursor_plane_move)
[203.699114] Subtest cursor_plane_move: SKIP (0.000s)
[203.794702] [127/171] (811s left) kms_psr (sprite_plane_onoff)
[204.176689] Subtest sprite_plane_onoff: SKIP (0.000s)
[204.270836] [128/171] (811s left) kms_psr (primary_mmap_gtt)
[204.662198] Subtest primary_mmap_gtt: SKIP (0.000s)
[204.756300] [129/171] (810s left) kms_setmode (basic-clone-single-crtc)
[205.140067] Starting subtest: basic-clone-single-crtc
[205.161974] Subtest basic-clone-single-crtc: SKIP (0.002s)
[205.269710] [130/171] (810s left) i915_pm_backlight (basic-brightness)
[205.796696] Subtest basic-brightness: SKIP (0.000s)
[205.893884] [131/171] (809s left) i915_pm_rpm (basic-pci-d3-state)
[208.233449] Starting subtest: basic-pci-d3-state
[209.940229] Subtest basic-pci-d3-state: SUCCESS (1.704s)
[210.067343] [132/171] (805s left) i915_pm_rpm (basic-rte)
[210.443494] Starting subtest: basic-rte
[213.283511] Subtest basic-rte: SUCCESS (2.841s)
[214.058479] [133/171] (801s left) i915_pm_rps (basic-api)
[214.470579] Starting subtest: basic-api
[214.483929] Subtest basic-api: SKIP (0.001s)
[214.623304] [134/171] (801s left) prime_self_import (basic-llseek-bad)
[214.998950] Starting subtest: basic-llseek-bad
[215.012567] Subtest basic-llseek-bad: SUCCESS (0.011s)
[215.156524] [135/171] (801s left) prime_self_import (basic-llseek-size)
[215.525438] Starting subtest: basic-llseek-size
[215.538976] Subtest basic-llseek-size: SUCCESS (0.013s)
[215.664859] [136/171] (800s left) prime_self_import (basic-with_fd_dup)
[216.032475] Starting subtest: basic-with_fd_dup
[216.045728] Subtest basic-with_fd_dup: SUCCESS (0.013s)
[216.196101] [137/171] (800s left) prime_self_import (basic-with_one_bo)
[216.572789] Starting subtest: basic-with_one_bo
[216.586125] Subtest basic-with_one_bo: SUCCESS (0.015s)
[216.701435] [138/171] (799s left) prime_self_import (basic-with_one_bo_two_files)
[217.076681] Starting subtest: basic-with_one_bo_two_files
[217.090316] Subtest basic-with_one_bo_two_files: SUCCESS (0.011s)
[217.226955] [139/171] (799s left) prime_self_import (basic-with_two_bos)
[217.597975] Starting subtest: basic-with_two_bos
[217.612348] Subtest basic-with_two_bos: SUCCESS (0.014s)
[217.752641] [140/171] (798s left) prime_vgem (basic-fence-flip)
[218.175682] Starting subtest: basic-fence-flip
[218.306117] Subtest basic-fence-flip: SKIP (0.118s)
[218.429625] [141/171] (798s left) prime_vgem (basic-fence-mmap)
[218.853643] Starting subtest: basic-fence-mmap
[218.867663] Subtest basic-fence-mmap: SKIP (0.000s)
[219.010103] [142/171] (797s left) prime_vgem (basic-fence-read)
[219.449619] Starting subtest: basic-fence-read
[219.486781] Subtest basic-fence-read: SKIP (0.031s)
[219.624650] [143/171] (797s left) prime_vgem (basic-gtt)
[220.036548] Starting subtest: basic-gtt
[220.050446] Subtest basic-gtt: SKIP (0.000s)
[220.190495] [144/171] (796s left) prime_vgem (basic-read)
[220.611149] Starting subtest: basic-read
[220.642487] Subtest basic-read: SKIP (0.025s)
[220.774522] [145/171] (796s left) prime_vgem (basic-write)
[221.187111] Starting subtest: basic-write
[221.218743] Subtest basic-write: SKIP (0.025s)
[221.355069] [146/171] (795s left) vgem_basic (setversion)
[221.754836] Starting subtest: setversion
[221.769717] Subtest setversion: SUCCESS (0.000s)
[221.855348] [147/171] (795s left) vgem_basic (create)
[222.258339] Starting subtest: create
[222.265530] Subtest create: SUCCESS (0.001s)
[222.373908] [148/171] (794s left) vgem_basic (debugfs)
[222.685934] Starting subtest: debugfs
[222.693251] Subtest debugfs: SUCCESS (0.002s)
[222.796618] [149/171] (794s left) vgem_basic (dmabuf-export)
[223.195867] Starting subtest: dmabuf-export
[223.209940] Subtest dmabuf-export: SUCCESS (0.009s)
[223.345226] [150/171] (794s left) vgem_basic (dmabuf-fence)
[223.743089] Starting subtest: dmabuf-fence
[223.750231] Subtest dmabuf-fence: SUCCESS (0.002s)
[223.837672] [151/171] (793s left) vgem_basic (dmabuf-fence-before)
[224.237598] Starting subtest: dmabuf-fence-before
[224.245152] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[224.337254] [152/171] (793s left) vgem_basic (dmabuf-mmap)
[224.734824] Starting subtest: dmabuf-mmap
[224.766067] Subtest dmabuf-mmap: SUCCESS (0.044s)
[224.876806] [153/171] (792s left) vgem_basic (mmap)
[225.277458] Starting subtest: mmap
[225.300706] Subtest mmap: SUCCESS (0.033s)
[225.408978] [154/171] (792s left) vgem_basic (second-client)
[225.805859] Starting subtest: second-client
[225.835159] Subtest second-client: SUCCESS (0.031s)
[225.937837] [155/171] (791s left) vgem_basic (sysfs)
[226.331269] Starting subtest: sysfs
[226.338952] Subtest sysfs: SUCCESS (0.003s)
[226.437972] [156/171] (791s left) core_hotunplug (unbind-rebind)
[226.930077] Starting subtest: unbind-rebind
[230.943553] Subtest unbind-rebind: SUCCESS (4.013s)
[231.015438] [157/171] (787s left) vgem_basic (unload)
[231.318379] Starting subtest: unload
[260.369069] Subtest unload: SUCCESS (29.046s)
[260.510914] [158/171] (757s left) i915_module_load (reload)
[260.884574] Starting subtest: reload
[267.316795] Subtest reload: SUCCESS (6.437s)
[267.397416] [159/171] (750s left) gem_lmem_swapping (basic)
[267.731924] Subtest basic: SKIP (0.000s)
[267.804157] [160/171] (750s left) gem_lmem_swapping (parallel-random-engines)
[268.212139] Subtest parallel-random-engines: SKIP (0.000s)
[268.284737] [161/171] (750s left) gem_lmem_swapping (random-engines)
[268.682741] Subtest random-engines: SKIP (0.000s)
[268.754653] [162/171] (749s left) gem_lmem_swapping (verify-random)
[269.151738] Subtest verify-random: SKIP (0.000s)
[269.244896] [163/171] (749s left) i915_pm_rpm (module-reload)
[271.568084] Starting subtest: module-reload
[286.621207] Subtest module-reload: SUCCESS (15.045s)
[286.682268] [164/171] (732s left) i915_selftest (live)
[287.060347] Starting subtest: live
[287.067307] Starting dynamic subtest: sanitycheck
[291.257241] Dynamic subtest sanitycheck: SUCCESS (4.188s)
[291.288829] Starting dynamic subtest: uncore
[295.384412] Dynamic subtest uncore: SUCCESS (4.125s)
[295.415808] Starting dynamic subtest: workarounds
[300.777901] Dynamic subtest workarounds: SUCCESS (5.393s)
[300.810127] Starting dynamic subtest: gt_engines
[305.362728] Dynamic subtest gt_engines: SUCCESS (4.583s)
[305.416520] Starting dynamic subtest: gt_timelines
[329.179156] Dynamic subtest gt_timelines: SUCCESS (23.813s)
[329.211470] Starting dynamic subtest: gt_contexts
[333.334358] Dynamic subtest gt_contexts: SUCCESS (4.163s)
[333.369508] Starting dynamic subtest: gt_lrc
[340.124358] Dynamic subtest gt_lrc: SUCCESS (6.781s)
[340.168648] Starting dynamic subtest: gt_mocs
[345.116895] Dynamic subtest gt_mocs: SUCCESS (4.990s)
[345.150443] Starting dynamic subtest: gt_pm
[350.043937] Dynamic subtest gt_pm: SUCCESS (4.924s)
[350.101451] Starting dynamic subtest: gt_heartbeat
[354.239491] Dynamic subtest gt_heartbeat: SUCCESS (4.191s)
[354.270951] Starting dynamic subtest: gt_tlb
[360.468174] Dynamic subtest gt_tlb: SUCCESS (6.227s)
[360.500063] Starting dynamic subtest: requests
[394.539935] Dynamic subtest requests: FAIL (33.088s)
[394.572939] Starting dynamic subtest: migrate
[402.810244] Dynamic subtest migrate: SUCCESS (9.247s)
[402.844191] Starting dynamic subtest: active
[406.644337] Dynamic subtest active: SUCCESS (3.829s)
[406.676333] Starting dynamic subtest: objects
[413.715962] Dynamic subtest objects: SUCCESS (7.072s)
[413.748119] Starting dynamic subtest: mman
[422.543113] Dynamic subtest mman: SUCCESS (8.824s)
[422.581838] Starting dynamic subtest: dmabuf
[426.779759] Dynamic subtest dmabuf: SUCCESS (4.234s)
[426.811811] Starting dynamic subtest: vma
[430.890839] Dynamic subtest vma: SUCCESS (4.107s)
[430.922783] Starting dynamic subtest: coherency
[438.606971] Dynamic subtest coherency: SUCCESS (7.714s)
[438.639162] Starting dynamic subtest: gtt
[451.398118] Dynamic subtest gtt: SUCCESS (12.787s)
[451.430329] Starting dynamic subtest: gem
[459.691136] Dynamic subtest gem: SUCCESS (8.290s)
[459.723111] Starting dynamic subtest: evict
[466.546720] Dynamic subtest evict: SUCCESS (6.858s)
[466.579394] Starting dynamic subtest: hugepages
[477.567715] Dynamic subtest hugepages: SUCCESS (11.007s)
[477.601387] Starting dynamic subtest: gem_contexts
[527.481413] Dynamic subtest gem_contexts: SUCCESS (49.910s)
[527.514050] Starting dynamic subtest: client
[531.746232] Dynamic subtest client: SUCCESS (4.264s)
[531.779384] Starting dynamic subtest: gem_migrate
[535.892283] Dynamic subtest gem_migrate: SUCCESS (4.142s)
[535.925065] Starting dynamic subtest: reset
[540.201508] Dynamic subtest reset: SUCCESS (4.303s)
[540.236042] Starting dynamic subtest: memory_region
[544.376135] Dynamic subtest memory_region: SUCCESS (4.171s)
[544.409128] Starting dynamic subtest: hangcheck
[562.427644] Dynamic subtest hangcheck: SUCCESS (18.051s)
[562.460523] Starting dynamic subtest: execlists
[566.573315] Dynamic subtest execlists: SUCCESS (4.142s)
[566.606826] Starting dynamic subtest: ring_submission
[570.565420] Dynamic subtest ring_submission: SUCCESS (3.986s)
[570.598198] Starting dynamic subtest: perf
[574.875335] Dynamic subtest perf: SUCCESS (4.307s)
[574.909894] Starting dynamic subtest: slpc
[587.793854] Dynamic subtest slpc: SUCCESS (12.916s)
[587.828169] Starting dynamic subtest: guc
[593.858136] Dynamic subtest guc: SUCCESS (6.062s)
[593.891152] Starting dynamic subtest: guc_multi_lrc
[598.021274] Dynamic subtest guc_multi_lrc: SUCCESS (4.159s)
[598.054473] Starting dynamic subtest: guc_hang
[603.016081] Dynamic subtest guc_hang: SUCCESS (4.991s)
[603.049156] Starting dynamic subtest: late_gt_pm
[607.258161] Dynamic subtest late_gt_pm: SUCCESS (4.238s)
[607.265683] Subtest live: FAIL (320.192s)
[607.526891] [165/171] (411s left) dmabuf (all-tests)
[607.903794] Starting subtest: all-tests
[607.911038] Starting dynamic subtest: sanitycheck
[607.980873] Dynamic subtest sanitycheck: SUCCESS (0.076s)
[608.011442] Starting dynamic subtest: dma_fence
[608.176986] Dynamic subtest dma_fence: SUCCESS (0.194s)
[608.215036] Starting dynamic subtest: dma_fence_chain
[620.501995] Dynamic subtest dma_fence_chain: SUCCESS (12.312s)
[620.557252] Starting dynamic subtest: dma_fence_unwrap
[620.583728] Dynamic subtest dma_fence_unwrap: SUCCESS (0.085s)
[620.618584] Starting dynamic subtest: dma_resv
[620.668899] Dynamic subtest dma_resv: SUCCESS (0.085s)
[620.675980] Subtest all-tests: SUCCESS (12.767s)
[620.758219] [166/171] (398s left) i915_suspend (basic-s2idle-without-i915)
[621.130655] Starting subtest: basic-s2idle-without-i915
[645.533672] Subtest basic-s2idle-without-i915: SUCCESS (24.402s)
[646.617189] [167/171] (373s left) i915_suspend (basic-s3-without-i915)
[646.989445] Starting subtest: basic-s3-without-i915
[649.222543] Subtest basic-s3-without-i915: SKIP (2.215s)
[652.278326] [168/171] (367s left) gem_exec_suspend (basic-s0)
[652.673495] Starting subtest: basic-S0
[652.684665] Starting dynamic subtest: smem
[679.175944] Dynamic subtest smem: SUCCESS (26.496s)
[679.183858] Subtest basic-S0: SUCCESS (26.499s)
[680.401409] [169/171] (340s left) gem_exec_suspend (basic-s3)
[680.844275] Starting subtest: basic-S3
[680.851484] Starting dynamic subtest: smem
[707.147849] Dynamic subtest smem: SUCCESS (26.298s)
[707.155580] Subtest basic-S3: SUCCESS (26.302s)
[708.359163] [170/171] (313s left) kms_chamelium_hpd (common-hpd-after-suspend)
[708.936759] Subtest common-hpd-after-suspend: SKIP (0.000s)
[709.021099] [171/171] (313s left) kms_pipe_crc_basic (suspend-read-crc)
[709.543717] Subtest suspend-read-crc: SKIP (0.000s)
[709.609475] Closing watchdogs
Done.