[37.353091] Initializing watchdogs
[37.353239]   /dev/watchdog0
[37.361521] [001/171] (960s left) i915_module_load (load)
[37.493075] Starting subtest: load
[39.105571] Subtest load: SUCCESS (1.612s)
[39.133738] [002/171] (958s left) core_auth (basic-auth)
[39.267831] Starting subtest: basic-auth
[39.268956] Subtest basic-auth: SUCCESS (0.002s)
[39.345979] [003/171] (958s left) debugfs_test (read_all_entries)
[39.495034] Starting subtest: read_all_entries
[39.611056] Subtest read_all_entries: SUCCESS (0.114s)
[39.741908] [004/171] (958s left) debugfs_test (basic-hwmon)
[39.931267] Starting subtest: basic-hwmon
[39.933480] Subtest basic-hwmon: SKIP (0.000s)
[40.033377] [005/171] (957s left) fbdev (eof)
[40.161720] Starting subtest: eof
[40.162847] Subtest eof: SUCCESS (0.001s)
[40.217856] [006/171] (957s left) fbdev (info)
[40.347758] Starting subtest: info
[40.348969] Subtest info: SUCCESS (0.000s)
[40.418569] [007/171] (957s left) fbdev (nullptr)
[40.562828] Starting subtest: nullptr
[40.563993] Subtest nullptr: SUCCESS (0.000s)
[40.619348] [008/171] (957s left) fbdev (read)
[40.745434] Starting subtest: read
[40.976090] Subtest read: SUCCESS (0.229s)
[41.039172] [009/171] (957s left) fbdev (write)
[41.163861] Starting subtest: write
[41.283091] Subtest write: SUCCESS (0.119s)
[41.338621] [010/171] (956s left) gem_basic (bad-close)
[41.462255] Starting subtest: bad-close
[41.465373] Subtest bad-close: SUCCESS (0.000s)
[41.523092] [011/171] (956s left) gem_basic (create-close)
[41.650042] Starting subtest: create-close
[41.652256] Subtest create-close: SUCCESS (0.000s)
[41.723309] [012/171] (956s left) gem_basic (create-fd-close)
[41.851636] Starting subtest: create-fd-close
[41.853756] Subtest create-fd-close: SUCCESS (0.000s)
[41.924364] [013/171] (956s left) gem_busy (busy@all-engines)
[42.063571] Starting subtest: busy
[42.064904] Starting dynamic subtest: all-engines
[42.088026] Dynamic subtest all-engines: SUCCESS (0.024s)
[42.091499] Subtest busy: SUCCESS (0.025s)
[42.410036] [014/171] (955s left) gem_close_race (basic-process)
[42.547680] Starting subtest: basic-process
[42.589363] Subtest basic-process: SUCCESS (0.042s)
[42.778403] [015/171] (955s left) gem_close_race (basic-threads)
[42.976694] Starting subtest: basic-threads
[44.102693] Subtest basic-threads: SUCCESS (1.126s)
[44.282969] [016/171] (953s left) gem_ctx_create (basic)
[44.413093] Subtest basic: SKIP (0.000s)
[44.453539] [017/171] (953s left) gem_ctx_create (basic-files)
[44.584112] Subtest basic-files: SKIP (0.000s)
[44.619286] [018/171] (953s left) gem_ctx_exec (basic)
[44.746866] Subtest basic: SKIP (0.000s)
[44.826305] [019/171] (953s left) gem_exec_basic (basic)
[44.957706] Starting subtest: basic
[44.958829] Starting dynamic subtest: rcs0-smem
[44.959934] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[44.961083] Subtest basic: SUCCESS (0.001s)
[45.135375] [020/171] (953s left) gem_exec_create (basic)
[45.272409] Starting subtest: basic
[45.273526] Starting dynamic subtest: smem
[47.308339] Dynamic subtest smem: SUCCESS (2.037s)
[47.309577] Subtest basic: SUCCESS (2.038s)
[47.494405] [021/171] (950s left) gem_exec_fence (basic-busy)
[47.753665] Starting subtest: basic-busy
[47.754862] Starting dynamic subtest: rcs0
[47.764128] Dynamic subtest rcs0: SUCCESS (0.013s)
[47.765298] Subtest basic-busy: SUCCESS (0.013s)
[48.248884] [022/171] (950s left) gem_exec_fence (basic-wait)
[48.507147] Starting subtest: basic-wait
[48.508333] Starting dynamic subtest: rcs0
[48.525190] Dynamic subtest rcs0: SUCCESS (0.019s)
[48.526344] Subtest basic-wait: SUCCESS (0.020s)
[48.981095] [023/171] (949s left) gem_exec_fence (basic-await)
[49.240853] Starting subtest: basic-await
[49.241948] Starting dynamic subtest: rcs0
[49.304209] Dynamic subtest rcs0: SUCCESS (0.063s)
[49.305385] Subtest basic-await: SUCCESS (0.064s)
[49.752389] [024/171] (948s left) gem_exec_fence (nb-await)
[50.010865] Starting subtest: nb-await
[50.012141] Starting dynamic subtest: rcs0
[50.062203] Dynamic subtest rcs0: SUCCESS (0.053s)
[50.063208] Subtest nb-await: SUCCESS (0.053s)
[50.503950] [025/171] (947s left) gem_exec_gttfill (basic)
[50.640477] Starting subtest: basic
[53.863212] Subtest basic: SUCCESS (3.221s)
[54.038875] [026/171] (944s left) gem_exec_parallel (engines)
[54.303292] Starting subtest: engines
[54.304630] Starting dynamic subtest: basic
[56.126940] Dynamic subtest basic: SUCCESS (1.825s)
[56.140944] Starting dynamic subtest: contexts
[56.144922] Dynamic subtest contexts: SKIP (0.001s)
[56.152617] Starting dynamic subtest: fds
[56.154746] Dynamic subtest fds: SKIP (0.001s)
[56.162292] Starting dynamic subtest: userptr
[57.945235] Dynamic subtest userptr: SUCCESS (1.816s)
[57.946364] Subtest engines: SUCCESS (3.644s)
[58.133203] [027/171] (940s left) gem_exec_store (basic)
[58.267449] Starting subtest: basic
[58.292342] Subtest basic: SUCCESS (0.025s)
[58.482012] [028/171] (939s left) gem_flink_basic (bad-flink)
[58.606077] Starting subtest: bad-flink
[58.607191] Subtest bad-flink: SUCCESS (0.000s)
[58.683828] [029/171] (939s left) gem_flink_basic (bad-open)
[58.810915] Starting subtest: bad-open
[58.812097] Subtest bad-open: SUCCESS (0.000s)
[58.882598] [030/171] (939s left) gem_flink_basic (basic)
[59.005144] Starting subtest: basic
[59.006272] Subtest basic: SUCCESS (0.000s)
[59.085292] [031/171] (939s left) gem_flink_basic (double-flink)
[59.210214] Starting subtest: double-flink
[59.211618] Subtest double-flink: SUCCESS (0.000s)
[59.284988] [032/171] (939s left) gem_flink_basic (flink-lifetime)
[59.410616] Starting subtest: flink-lifetime
[59.411692] Subtest flink-lifetime: SUCCESS (0.001s)
[59.485332] [033/171] (939s left) gem_huc_copy (huc-copy)
[59.614423] Subtest huc-copy: SKIP (0.000s)
[59.655876] [034/171] (938s left) gem_linear_blits (basic)
[60.020527] Starting subtest: basic
[60.033171] Subtest basic: SUCCESS (0.012s)
[60.152736] [035/171] (938s left) gem_mmap (basic)
[60.395562] Starting subtest: basic
[60.401915] Subtest basic: SUCCESS (0.001s)
[60.473259] [036/171] (938s left) gem_mmap_gtt (basic)
[60.600160] Starting subtest: basic
[60.601209] Subtest basic: SUCCESS (0.001s)
[60.656324] [037/171] (937s left) gem_render_linear_blits (basic)
[60.781853] Starting subtest: basic
[60.816622] Subtest basic: SUCCESS (0.038s)
[60.859386] [038/171] (937s left) gem_render_tiled_blits (basic)
[60.987251] Starting subtest: basic
[61.022241] Subtest basic: SUCCESS (0.037s)
[61.059828] [039/171] (937s left) gem_ringfill (basic-all)
[61.209500] Starting subtest: basic-all
[62.313254] Subtest basic-all: SUCCESS (1.102s)
[62.382093] [040/171] (936s left) gem_softpin (allocator-basic)
[62.507082] Subtest allocator-basic: SKIP (0.000s)
[62.579395] [041/171] (936s left) gem_softpin (allocator-basic-reserve)
[62.705451] Subtest allocator-basic-reserve: SKIP (0.000s)
[62.780550] [042/171] (935s left) gem_softpin (safe-alignment)
[62.910383] Starting subtest: safe-alignment
[62.911636] Subtest safe-alignment: SUCCESS (0.006s)
[62.980824] [043/171] (935s left) gem_sync (basic-all)
[63.117427] Starting subtest: basic-all
[65.191461] Subtest basic-all: SUCCESS (2.077s)
[65.373827] [044/171] (933s left) gem_sync (basic-each)
[65.508494] Starting subtest: basic-each
[67.561264] Subtest basic-each: SUCCESS (2.051s)
[67.748392] [045/171] (931s left) gem_tiled_blits (basic)
[68.108300] Starting subtest: basic
[68.129352] Subtest basic: SUCCESS (0.021s)
[68.228506] [046/171] (930s left) gem_tiled_fence_blits (basic)
[68.775945] Starting subtest: basic
[68.788305] Subtest basic: SUCCESS (0.013s)
[68.902912] [047/171] (929s left) gem_tiled_pread_basic
[69.403464] [048/171] (929s left) gem_wait (busy@all-engines)
[69.550127] Starting subtest: busy
[69.552167] Starting dynamic subtest: all-engines
[70.063093] Dynamic subtest all-engines: SUCCESS (0.513s)
[70.064862] Subtest busy: SUCCESS (0.514s)
[70.274376] [049/171] (928s left) gem_wait (wait@all-engines)
[70.420628] Starting subtest: wait
[70.421820] Starting dynamic subtest: all-engines
[71.431185] Dynamic subtest all-engines: SUCCESS (1.013s)
[71.432396] Subtest wait: SUCCESS (1.013s)
[71.644740] [050/171] (927s left) i915_getparams_basic (basic-eu-total)
[71.769862] Starting subtest: basic-eu-total
[71.772115] Subtest basic-eu-total: SUCCESS (0.000s)
[71.844518] [051/171] (927s left) i915_getparams_basic (basic-subslice-total)
[71.967991] Starting subtest: basic-subslice-total
[71.970193] Subtest basic-subslice-total: SUCCESS (0.000s)
[72.030405] [052/171] (926s left) i915_hangman (error-state-basic)
[72.159102] Starting subtest: error-state-basic
[72.270374] Subtest error-state-basic: SUCCESS (0.114s)
[72.324372] [053/171] (926s left) i915_pciid
[72.521921] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[72.647416] Starting subtest: addfb25-bad-modifier
[72.649841] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[72.756802] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[72.884036] Starting subtest: addfb25-framebuffer-vs-set-tiling
[72.885187] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[72.992654] [056/171] (926s left) kms_addfb_basic (addfb25-modifier-no-flag)
[73.121608] Starting subtest: addfb25-modifier-no-flag
[73.122859] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[73.226659] [057/171] (925s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[73.356209] Starting subtest: addfb25-x-tiled-legacy
[73.357318] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[73.460862] [058/171] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[73.589374] Starting subtest: addfb25-x-tiled-mismatch-legacy
[73.590515] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[73.696257] [059/171] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[73.853841] Starting subtest: addfb25-yf-tiled-legacy
[73.855151] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[73.926699] [060/171] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[74.085431] Starting subtest: addfb25-y-tiled-legacy
[74.086749] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[74.162123] [061/171] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[74.336788] Starting subtest: addfb25-y-tiled-small-legacy
[74.340484] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[74.412337] [062/171] (924s left) kms_addfb_basic (bad-pitch-0)
[74.539270] Starting subtest: bad-pitch-0
[74.540449] Subtest bad-pitch-0: SUCCESS (0.000s)
[74.648238] [063/171] (924s left) kms_addfb_basic (bad-pitch-1024)
[74.778860] Starting subtest: bad-pitch-1024
[74.780034] Subtest bad-pitch-1024: SUCCESS (0.000s)
[74.881564] [064/171] (924s left) kms_addfb_basic (bad-pitch-128)
[75.005750] Starting subtest: bad-pitch-128
[75.008945] Subtest bad-pitch-128: SUCCESS (0.000s)
[75.115582] [065/171] (924s left) kms_addfb_basic (bad-pitch-256)
[75.243119] Starting subtest: bad-pitch-256
[75.244205] Subtest bad-pitch-256: SUCCESS (0.000s)
[75.349824] [066/171] (923s left) kms_addfb_basic (bad-pitch-32)
[75.478599] Starting subtest: bad-pitch-32
[75.479758] Subtest bad-pitch-32: SUCCESS (0.000s)
[75.586689] [067/171] (923s left) kms_addfb_basic (bad-pitch-63)
[75.712161] Starting subtest: bad-pitch-63
[75.713540] Subtest bad-pitch-63: SUCCESS (0.000s)
[75.817826] [068/171] (923s left) kms_addfb_basic (bad-pitch-65536)
[75.948385] Starting subtest: bad-pitch-65536
[75.949605] Subtest bad-pitch-65536: SUCCESS (0.000s)
[76.052311] [069/171] (923s left) kms_addfb_basic (bad-pitch-999)
[76.179380] Starting subtest: bad-pitch-999
[76.180599] Subtest bad-pitch-999: SUCCESS (0.000s)
[76.286402] [070/171] (923s left) kms_addfb_basic (basic)
[76.414040] Starting subtest: basic
[76.417412] Subtest basic: SUCCESS (0.000s)
[76.521393] [071/171] (922s left) kms_addfb_basic (basic-x-tiled-legacy)
[76.649295] Starting subtest: basic-x-tiled-legacy
[76.650575] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[76.753203] [072/171] (922s left) kms_addfb_basic (basic-y-tiled-legacy)
[76.878141] Starting subtest: basic-y-tiled-legacy
[76.879476] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[76.989633] [073/171] (922s left) kms_addfb_basic (bo-too-small)
[77.146535] Starting subtest: bo-too-small
[77.147796] Subtest bo-too-small: SUCCESS (0.000s)
[77.222080] [074/171] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[77.382959] Starting subtest: bo-too-small-due-to-tiling
[77.384379] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[77.455563] [075/171] (922s left) kms_addfb_basic (clobberred-modifier)
[77.584021] Starting subtest: clobberred-modifier
[77.589051] Subtest clobberred-modifier: SUCCESS (0.000s)
[77.691957] [076/171] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[77.819257] Starting subtest: framebuffer-vs-set-tiling
[77.820416] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[77.927968] [077/171] (921s left) kms_addfb_basic (invalid-get-prop)
[78.057481] Starting subtest: invalid-get-prop
[78.058670] Subtest invalid-get-prop: SUCCESS (0.000s)
[78.158543] [078/171] (921s left) kms_addfb_basic (invalid-get-prop-any)
[78.284329] Starting subtest: invalid-get-prop-any
[78.285553] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[78.394418] [079/171] (921s left) kms_addfb_basic (invalid-set-prop)
[78.520655] Starting subtest: invalid-set-prop
[78.521826] Subtest invalid-set-prop: SUCCESS (0.000s)
[78.627934] [080/171] (920s left) kms_addfb_basic (invalid-set-prop-any)
[78.756584] Starting subtest: invalid-set-prop-any
[78.757738] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[78.862947] [081/171] (920s left) kms_addfb_basic (no-handle)
[78.990595] Starting subtest: no-handle
[78.991800] Subtest no-handle: SUCCESS (0.000s)
[79.095806] [082/171] (920s left) kms_addfb_basic (size-max)
[79.255997] Starting subtest: size-max
[79.257226] Subtest size-max: SUCCESS (0.000s)
[79.329532] [083/171] (920s left) kms_addfb_basic (small-bo)
[79.490396] Starting subtest: small-bo
[79.491765] Subtest small-bo: SUCCESS (0.000s)
[79.565116] [084/171] (920s left) kms_addfb_basic (tile-pitch-mismatch)
[79.693956] Starting subtest: tile-pitch-mismatch
[79.695075] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[79.801274] [085/171] (919s left) kms_addfb_basic (too-high)
[79.955625] Starting subtest: too-high
[79.956995] Subtest too-high: SUCCESS (0.002s)
[80.030611] [086/171] (919s left) kms_addfb_basic (too-wide)
[80.190378] Starting subtest: too-wide
[80.191831] Subtest too-wide: SUCCESS (0.000s)
[80.265837] [087/171] (919s left) kms_addfb_basic (unused-handle)
[80.393193] Starting subtest: unused-handle
[80.394321] Subtest unused-handle: SUCCESS (0.000s)
[80.500447] [088/171] (919s left) kms_addfb_basic (unused-modifier)
[80.625345] Starting subtest: unused-modifier
[80.626742] Subtest unused-modifier: SUCCESS (0.000s)
[80.736362] [089/171] (919s left) kms_addfb_basic (unused-offsets)
[80.860297] Starting subtest: unused-offsets
[80.861498] Subtest unused-offsets: SUCCESS (0.000s)
[80.969188] [090/171] (918s left) kms_addfb_basic (unused-pitches)
[81.099058] Starting subtest: unused-pitches
[81.100171] Subtest unused-pitches: SUCCESS (0.000s)
[81.204247] [091/171] (918s left) kms_busy (basic)
[81.361915] Starting subtest: basic
[81.365166] Starting dynamic subtest: flip
[82.015182] Dynamic subtest flip: SUCCESS (0.650s)
[82.024115] Starting dynamic subtest: modeset
[82.027987] Dynamic subtest modeset: SKIP (0.000s)
[82.029148] Subtest basic: SUCCESS (0.653s)
[82.139810] [092/171] (917s left) kms_chamelium_hpd (dp-hpd-fast)
[82.294417] Subtest dp-hpd-fast: SKIP (0.000s)
[82.338817] [093/171] (917s left) kms_chamelium_edid (dp-edid-read)
[82.495390] Subtest dp-edid-read: SKIP (0.000s)
[82.538856] [094/171] (917s left) kms_chamelium_frames (dp-crc-fast)
[82.695082] Subtest dp-crc-fast: SKIP (0.000s)
[82.739423] [095/171] (917s left) kms_chamelium_hpd (hdmi-hpd-fast)
[82.897406] Subtest hdmi-hpd-fast: SKIP (0.000s)
[82.940100] [096/171] (917s left) kms_chamelium_edid (hdmi-edid-read)
[83.098776] Subtest hdmi-edid-read: SKIP (0.000s)
[83.140937] [097/171] (916s left) kms_chamelium_frames (hdmi-crc-fast)
[83.296123] Subtest hdmi-crc-fast: SKIP (0.000s)
[83.341682] [098/171] (916s left) kms_chamelium_hpd (vga-hpd-fast)
[83.500738] Subtest vga-hpd-fast: SKIP (0.000s)
[83.542297] [099/171] (916s left) kms_chamelium_edid (vga-edid-read)
[83.699220] Subtest vga-edid-read: SKIP (0.000s)
[83.742772] [100/171] (916s left) kms_prop_blob (basic)
[83.869403] Starting subtest: basic
[83.870617] Subtest basic: SUCCESS (0.000s)
[83.943270] [101/171] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[84.100448] Starting subtest: basic-busy-flip-before-cursor-atomic
[84.105369] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.005s)
[84.176481] [102/171] (915s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[84.337124] Starting subtest: basic-busy-flip-before-cursor-legacy
[85.355756] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.014s)
[85.479972] [103/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[85.636532] Starting subtest: basic-flip-after-cursor-atomic
[85.639114] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[85.713709] [104/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[85.870836] Starting subtest: basic-flip-after-cursor-legacy
[86.872940] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.002s)
[87.001725] [105/171] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[87.158886] Starting subtest: basic-flip-after-cursor-varying-size
[88.177249] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.012s)
[88.294766] [106/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[88.450504] Starting subtest: basic-flip-before-cursor-atomic
[88.453112] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[88.527657] [107/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[88.670533] Starting subtest: basic-flip-before-cursor-legacy
[89.668843] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.998s)
[89.794047] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[89.950755] Starting subtest: basic-flip-before-cursor-varying-size
[90.961902] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.011s)
[91.088415] [109/171] (909s left) kms_flip (basic-flip-vs-dpms)
[91.247506] Starting subtest: basic-flip-vs-dpms
[91.248798] Starting dynamic subtest: A-VGA1
[92.558753] Dynamic subtest A-VGA1: SUCCESS (1.309s)
[92.576131] Starting dynamic subtest: B-VGA1
[93.783064] Dynamic subtest B-VGA1: SUCCESS (1.211s)
[93.784231] Subtest basic-flip-vs-dpms: SUCCESS (2.533s)
[93.919056] [110/171] (906s left) kms_flip (basic-flip-vs-modeset)
[94.076022] Starting subtest: basic-flip-vs-modeset
[94.077163] Starting dynamic subtest: A-VGA1
[95.364615] Dynamic subtest A-VGA1: SUCCESS (1.288s)
[95.376903] Starting dynamic subtest: B-VGA1
[96.626951] Dynamic subtest B-VGA1: SUCCESS (1.263s)
[96.628065] Subtest basic-flip-vs-modeset: SUCCESS (2.552s)
[96.767020] [111/171] (903s left) kms_flip (basic-flip-vs-wf_vblank)
[96.922542] Starting subtest: basic-flip-vs-wf_vblank
[96.923831] Starting dynamic subtest: A-VGA1
[98.466990] Dynamic subtest A-VGA1: SUCCESS (1.543s)
[98.484152] Starting dynamic subtest: B-VGA1
[99.991957] Dynamic subtest B-VGA1: SUCCESS (1.517s)
[99.994044] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.071s)
[100.186837] [112/171] (900s left) kms_flip (basic-plain-flip)
[100.345920] Starting subtest: basic-plain-flip
[100.347183] Starting dynamic subtest: A-VGA1
[101.620137] Dynamic subtest A-VGA1: SUCCESS (1.266s)
[101.641236] Starting dynamic subtest: B-VGA1
[102.865056] Dynamic subtest B-VGA1: SUCCESS (1.219s)
[102.867043] Subtest basic-plain-flip: SUCCESS (2.521s)
[103.066947] [113/171] (897s left) kms_force_connector_basic (force-connector-state)
[103.256324] Starting subtest: force-connector-state
[103.450907] Subtest force-connector-state: SUCCESS (0.194s)
[103.726886] [114/171] (896s left) kms_force_connector_basic (force-edid)
[103.917682] Starting subtest: force-edid
[104.001153] Subtest force-edid: SUCCESS (0.083s)
[104.222536] [115/171] (896s left) kms_force_connector_basic (force-load-detect)
[104.519261] Starting subtest: force-load-detect
[104.706795] Subtest force-load-detect: SUCCESS (0.185s)
[104.929400] [116/171] (895s left) kms_force_connector_basic (prune-stale-modes)
[105.137071] Starting subtest: prune-stale-modes
[105.238545] Subtest prune-stale-modes: SUCCESS (0.102s)
[105.431177] [117/171] (894s left) kms_frontbuffer_tracking (basic)
[105.592193] Subtest basic: SKIP (0.000s)
[105.634449] [118/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[105.790890] Starting subtest: compare-crc-sanitycheck-xr24
[105.793282] Starting dynamic subtest: pipe-A-VGA-1
[106.104237] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.301s)
[106.129032] Starting dynamic subtest: pipe-B-VGA-1
[106.465035] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.341s)
[106.466200] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.670s)
[106.589592] [119/171] (893s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[106.745873] Starting subtest: compare-crc-sanitycheck-nv12
[106.747155] Starting dynamic subtest: pipe-A-VGA-1
[106.749405] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[106.759738] Starting dynamic subtest: pipe-B-VGA-1
[106.762973] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[106.765116] Subtest compare-crc-sanitycheck-nv12: SKIP (0.005s)
[106.829237] [120/171] (893s left) kms_pipe_crc_basic (hang-read-crc)
[106.981258] Starting subtest: hang-read-crc
[106.982436] Starting dynamic subtest: pipe-A-VGA-1
[107.941676] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.959s)
[107.953943] Starting dynamic subtest: pipe-B-VGA-1
[108.939670] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.996s)
[108.941062] Subtest hang-read-crc: SUCCESS (1.959s)
[109.062435] [121/171] (891s left) kms_pipe_crc_basic (nonblocking-crc)
[109.218932] Starting subtest: nonblocking-crc
[109.220124] Starting dynamic subtest: pipe-A-VGA-1
[109.704687] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.484s)
[109.720061] Starting dynamic subtest: pipe-B-VGA-1
[110.253919] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.548s)
[110.255226] Subtest nonblocking-crc: SUCCESS (1.035s)
[110.376509] [122/171] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[110.535267] Starting subtest: nonblocking-crc-frame-sequence
[110.536411] Starting dynamic subtest: pipe-A-VGA-1
[111.032188] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.495s)
[111.042971] Starting dynamic subtest: pipe-B-VGA-1
[111.575148] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.542s)
[111.576325] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.040s)
[111.699364] [123/171] (888s left) kms_pipe_crc_basic (read-crc)
[111.858148] Starting subtest: read-crc
[111.860510] Starting dynamic subtest: pipe-A-VGA-1
[112.289724] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.429s)
[112.304664] Starting dynamic subtest: pipe-B-VGA-1
[112.765156] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.473s)
[112.766448] Subtest read-crc: SUCCESS (0.907s)
[112.887821] [124/171] (887s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[113.046357] Starting subtest: read-crc-frame-sequence
[113.049039] Starting dynamic subtest: pipe-A-VGA-1
[113.476677] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.428s)
[113.488928] Starting dynamic subtest: pipe-B-VGA-1
[113.951997] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.473s)
[113.953338] Subtest read-crc-frame-sequence: SUCCESS (0.906s)
[114.076678] [125/171] (886s left) kms_psr (primary_page_flip)
[114.203456] Subtest primary_page_flip: SKIP (0.000s)
[114.245566] [126/171] (886s left) kms_psr (cursor_plane_move)
[114.371232] Subtest cursor_plane_move: SKIP (0.000s)
[114.412916] [127/171] (886s left) kms_psr (sprite_plane_onoff)
[114.539618] Subtest sprite_plane_onoff: SKIP (0.000s)
[114.581586] [128/171] (886s left) kms_psr (primary_mmap_gtt)
[114.731466] Subtest primary_mmap_gtt: SKIP (0.000s)
[114.764151] [129/171] (885s left) kms_setmode (basic-clone-single-crtc)
[114.888744] Starting subtest: basic-clone-single-crtc
[114.892633] Subtest basic-clone-single-crtc: SKIP (0.000s)
[114.961532] [130/171] (885s left) i915_pm_backlight (basic-brightness)
[115.119935] Subtest basic-brightness: SKIP (0.000s)
[115.165408] [131/171] (885s left) i915_pm_rpm (basic-pci-d3-state)
[126.487189] Subtest basic-pci-d3-state: SKIP (0.000s)
[126.504237] [132/171] (874s left) i915_pm_rpm (basic-rte)
[126.629239] Starting subtest: basic-rte
[137.840142] Subtest basic-rte: SKIP (11.194s)
[137.860296] [133/171] (862s left) i915_pm_rps (basic-api)
[137.992823] Subtest basic-api: SKIP (0.000s)
[138.028633] [134/171] (862s left) prime_self_import (basic-llseek-bad)
[138.146645] Starting subtest: basic-llseek-bad
[138.150215] Subtest basic-llseek-bad: SUCCESS (0.004s)
[138.227454] [135/171] (862s left) prime_self_import (basic-llseek-size)
[138.350064] Starting subtest: basic-llseek-size
[138.352397] Subtest basic-llseek-size: SUCCESS (0.003s)
[138.426129] [136/171] (862s left) prime_self_import (basic-with_fd_dup)
[138.547304] Starting subtest: basic-with_fd_dup
[138.549720] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[138.629239] [137/171] (862s left) prime_self_import (basic-with_one_bo)
[138.755203] Starting subtest: basic-with_one_bo
[138.757706] Subtest basic-with_one_bo: SUCCESS (0.004s)
[138.832234] [138/171] (862s left) prime_self_import (basic-with_one_bo_two_files)
[138.953872] Starting subtest: basic-with_one_bo_two_files
[138.956570] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[139.028795] [139/171] (861s left) prime_self_import (basic-with_two_bos)
[139.150957] Starting subtest: basic-with_two_bos
[139.156814] Subtest basic-with_two_bos: SUCCESS (0.006s)
[139.228855] [140/171] (861s left) prime_vgem (basic-fence-flip)
[139.361656] Starting subtest: basic-fence-flip
[139.761035] Subtest basic-fence-flip: SUCCESS (0.398s)
[139.833613] [141/171] (861s left) prime_vgem (basic-fence-mmap)
[139.980539] Starting subtest: basic-fence-mmap
[140.018868] Subtest basic-fence-mmap: SUCCESS (0.041s)
[140.099411] [142/171] (860s left) prime_vgem (basic-fence-read)
[140.231154] Starting subtest: basic-fence-read
[140.290763] Subtest basic-fence-read: SUCCESS (0.064s)
[140.367240] [143/171] (860s left) prime_vgem (basic-gtt)
[140.498990] Starting subtest: basic-gtt
[140.512132] Subtest basic-gtt: SUCCESS (0.017s)
[140.585923] [144/171] (860s left) prime_vgem (basic-read)
[140.716342] Starting subtest: basic-read
[140.740427] Subtest basic-read: SUCCESS (0.028s)
[140.821489] [145/171] (860s left) prime_vgem (basic-write)
[140.969547] Starting subtest: basic-write
[140.995726] Subtest basic-write: SUCCESS (0.033s)
[141.069552] [146/171] (860s left) vgem_basic (setversion)
[141.195035] Starting subtest: setversion
[141.197419] Subtest setversion: SUCCESS (0.000s)
[141.253874] [147/171] (859s left) vgem_basic (create)
[141.377206] Starting subtest: create
[141.379414] Subtest create: SUCCESS (0.000s)
[141.437249] [148/171] (859s left) vgem_basic (debugfs)
[141.561349] Starting subtest: debugfs
[141.563074] Subtest debugfs: SUCCESS (0.001s)
[141.622187] [149/171] (859s left) vgem_basic (dmabuf-export)
[141.745275] Starting subtest: dmabuf-export
[141.749228] Subtest dmabuf-export: SUCCESS (0.004s)
[141.821600] [150/171] (859s left) vgem_basic (dmabuf-fence)
[141.947639] Starting subtest: dmabuf-fence
[141.948817] Subtest dmabuf-fence: SUCCESS (0.001s)
[142.007130] [151/171] (859s left) vgem_basic (dmabuf-fence-before)
[142.131708] Starting subtest: dmabuf-fence-before
[142.132987] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[142.191905] [152/171] (859s left) vgem_basic (dmabuf-mmap)
[142.314322] Starting subtest: dmabuf-mmap
[142.333936] Subtest dmabuf-mmap: SUCCESS (0.021s)
[142.391849] [153/171] (858s left) vgem_basic (mmap)
[142.515224] Starting subtest: mmap
[142.526901] Subtest mmap: SUCCESS (0.013s)
[142.574732] [154/171] (858s left) vgem_basic (second-client)
[142.699175] Starting subtest: second-client
[142.733067] Subtest second-client: SUCCESS (0.033s)
[142.792380] [155/171] (858s left) vgem_basic (sysfs)
[142.917700] Starting subtest: sysfs
[142.918989] Subtest sysfs: SUCCESS (0.001s)
[142.978084] [156/171] (858s left) core_hotunplug (unbind-rebind)
[143.183097] Starting subtest: unbind-rebind
[143.948709] Subtest unbind-rebind: SUCCESS (0.764s)
[143.985269] [157/171] (857s left) vgem_basic (unload)
[144.155893] Starting subtest: unload
[173.106954] Subtest unload: SUCCESS (28.948s)
[173.209514] [158/171] (828s left) i915_module_load (reload)
[173.332041] Starting subtest: reload
[175.323062] Subtest reload: SUCCESS (1.987s)
[175.344104] [159/171] (826s left) gem_lmem_swapping (basic)
[175.507583] Subtest basic: SKIP (0.000s)
[175.545548] [160/171] (825s left) gem_lmem_swapping (parallel-random-engines)
[175.745823] Subtest parallel-random-engines: SKIP (0.000s)
[175.795764] [161/171] (825s left) gem_lmem_swapping (random-engines)
[175.944185] Subtest random-engines: SKIP (0.000s)
[175.980922] [162/171] (825s left) gem_lmem_swapping (verify-random)
[176.106838] Subtest verify-random: SKIP (0.000s)
[176.129818] [163/171] (825s left) i915_pm_rpm (module-reload)
[187.450049] Subtest module-reload: SKIP (0.000s)
[187.471508] [164/171] (814s left) i915_selftest (live)
[188.232376] Starting subtest: live
[188.233565] Starting dynamic subtest: sanitycheck
[188.976945] Dynamic subtest sanitycheck: SUCCESS (0.742s)
[188.985269] Starting dynamic subtest: uncore
[189.640582] Dynamic subtest uncore: SUCCESS (0.666s)
[189.651935] Starting dynamic subtest: workarounds
[190.294844] Dynamic subtest workarounds: SUCCESS (0.653s)
[190.306572] Starting dynamic subtest: gt_engines
[190.961742] Dynamic subtest gt_engines: SUCCESS (0.666s)
[190.972603] Starting dynamic subtest: gt_timelines
[193.898045] Dynamic subtest gt_timelines: SUCCESS (2.932s)
[193.906779] Starting dynamic subtest: gt_contexts
[194.572102] Dynamic subtest gt_contexts: SUCCESS (0.675s)
[194.581362] Starting dynamic subtest: gt_lrc
[195.215526] Dynamic subtest gt_lrc: SUCCESS (0.644s)
[195.224824] Starting dynamic subtest: gt_mocs
[195.867987] Dynamic subtest gt_mocs: SUCCESS (0.651s)
[195.879200] Starting dynamic subtest: gt_pm
[197.038141] Dynamic subtest gt_pm: SUCCESS (1.169s)
[197.049982] Starting dynamic subtest: gt_heartbeat
[197.706700] Dynamic subtest gt_heartbeat: SUCCESS (0.668s)
[197.715221] Starting dynamic subtest: gt_tlb
[198.370964] Dynamic subtest gt_tlb: SUCCESS (0.663s)
[198.382185] Starting dynamic subtest: requests
[201.622133] Dynamic subtest requests: SUCCESS (3.248s)
[201.630863] Starting dynamic subtest: migrate
[202.295171] Dynamic subtest migrate: SUCCESS (0.674s)
[202.306815] Starting dynamic subtest: active
[202.971980] Dynamic subtest active: SUCCESS (0.676s)
[202.984137] Starting dynamic subtest: objects
[203.968069] Dynamic subtest objects: SUCCESS (0.995s)
[203.980471] Starting dynamic subtest: mman
[208.889997] Dynamic subtest mman: SUCCESS (4.920s)
[208.900318] Starting dynamic subtest: dmabuf
[209.636161] Dynamic subtest dmabuf: SUCCESS (0.744s)
[209.644146] Starting dynamic subtest: vma
[210.332983] Dynamic subtest vma: SUCCESS (0.696s)
[210.342631] Starting dynamic subtest: coherency
[212.104142] Dynamic subtest coherency: SUCCESS (1.771s)
[212.115984] Starting dynamic subtest: gtt
[216.314162] Dynamic subtest gtt: SUCCESS (4.209s)
[216.324871] Starting dynamic subtest: gem
[217.046138] Dynamic subtest gem: SUCCESS (0.731s)
[217.057180] Starting dynamic subtest: evict
[217.753798] Dynamic subtest evict: SUCCESS (0.707s)
[217.765599] Starting dynamic subtest: hugepages
[218.406168] Dynamic subtest hugepages: SUCCESS (0.651s)
[218.413995] Starting dynamic subtest: gem_contexts
[219.029357] Dynamic subtest gem_contexts: SUCCESS (0.623s)
[219.040189] Starting dynamic subtest: client
[219.679865] Dynamic subtest client: SUCCESS (0.649s)
[219.691725] Starting dynamic subtest: gem_migrate
[220.362249] Dynamic subtest gem_migrate: SUCCESS (0.681s)
[220.373959] Starting dynamic subtest: reset
[221.398155] Dynamic subtest reset: SUCCESS (1.035s)
[221.410950] Starting dynamic subtest: memory_region
[222.078093] Dynamic subtest memory_region: SUCCESS (0.679s)
[222.089975] Starting dynamic subtest: hangcheck
[223.803141] Dynamic subtest hangcheck: SUCCESS (1.723s)
[223.813628] Starting dynamic subtest: execlists
[224.444480] Dynamic subtest execlists: SUCCESS (0.642s)
[224.455730] Starting dynamic subtest: ring_submission
[225.167118] Dynamic subtest ring_submission: SUCCESS (0.721s)
[225.177819] Starting dynamic subtest: perf
[225.811723] Dynamic subtest perf: SUCCESS (0.644s)
[225.822236] Starting dynamic subtest: slpc
[226.492247] Dynamic subtest slpc: SUCCESS (0.679s)
[226.503402] Starting dynamic subtest: guc
[227.156808] Dynamic subtest guc: SUCCESS (0.663s)
[227.167949] Starting dynamic subtest: guc_multi_lrc
[227.867098] Dynamic subtest guc_multi_lrc: SUCCESS (0.708s)
[227.877761] Starting dynamic subtest: guc_hang
[228.552941] Dynamic subtest guc_hang: SUCCESS (0.686s)
[228.564409] Starting dynamic subtest: late_gt_pm
[229.231798] Dynamic subtest late_gt_pm: SUCCESS (0.678s)
[229.233154] Subtest live: SUCCESS (41.001s)
[229.376597] [165/171] (772s left) dmabuf (all-tests)
[229.503337] Starting subtest: all-tests
[229.510865] Starting dynamic subtest: sanitycheck
[229.570087] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[229.577997] Starting dynamic subtest: dma_fence
[229.754391] Dynamic subtest dma_fence: SUCCESS (0.183s)
[229.762865] Starting dynamic subtest: dma_fence_chain
[247.414417] Dynamic subtest dma_fence_chain: SUCCESS (17.658s)
[247.428042] Starting dynamic subtest: dma_fence_unwrap
[247.472918] Dynamic subtest dma_fence_unwrap: SUCCESS (0.058s)
[247.487259] Starting dynamic subtest: dma_resv
[247.535176] Dynamic subtest dma_resv: SUCCESS (0.064s)
[247.537164] Subtest all-tests: SUCCESS (18.032s)
[247.557239] [166/171] (754s left) i915_suspend (basic-s2idle-without-i915)
[247.678850] Starting subtest: basic-s2idle-without-i915
[266.309736] Subtest basic-s2idle-without-i915: SUCCESS (18.633s)
[268.987869] [167/171] (735s left) i915_suspend (basic-s3-without-i915)
[269.118757] Starting subtest: basic-s3-without-i915
[285.956110] Subtest basic-s3-without-i915: SUCCESS (2.054s)
[288.739722] [168/171] (732s left) gem_exec_suspend (basic-s0)
[288.886399] Starting subtest: basic-S0
[288.887679] Starting dynamic subtest: smem
[305.951357] Dynamic subtest smem: SUCCESS (17.068s)
[305.952530] Subtest basic-S0: SUCCESS (17.069s)
[311.690233] [169/171] (715s left) gem_exec_suspend (basic-s3)
[311.830632] Starting subtest: basic-S3
[311.832141] Starting dynamic subtest: smem
[329.892228] Dynamic subtest smem: SUCCESS (1.889s)
[329.893472] Subtest basic-S3: SUCCESS (1.890s)
[335.094071] [170/171] (713s left) kms_chamelium_hpd (common-hpd-after-suspend)
[335.241214] Subtest common-hpd-after-suspend: SKIP (0.000s)
[335.288532] [171/171] (713s left) kms_pipe_crc_basic (suspend-read-crc)
[335.447316] Starting subtest: suspend-read-crc
[335.448583] Starting dynamic subtest: pipe-A-VGA-1
[352.866473] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.630s)
[352.885235] Starting dynamic subtest: pipe-B-VGA-1
[370.814150] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.601s)
[370.815431] Subtest suspend-read-crc: SUCCESS (3.234s)
[375.921723] Closing watchdogs
Done.