[35.837910] Initializing watchdogs
[35.838116]   /dev/watchdog0
[35.848317] [001/171] (960s left) i915_module_load (load)
[35.977351] Starting subtest: load
[37.562329] Subtest load: SUCCESS (1.586s)
[37.587265] [002/171] (958s left) core_auth (basic-auth)
[37.718139] Starting subtest: basic-auth
[37.719240] Subtest basic-auth: SUCCESS (0.001s)
[37.788416] [003/171] (958s left) debugfs_test (read_all_entries)
[37.931269] Starting subtest: read_all_entries
[38.051560] Subtest read_all_entries: SUCCESS (0.120s)
[38.169046] [004/171] (958s left) debugfs_test (basic-hwmon)
[38.343197] Starting subtest: basic-hwmon
[38.345396] Subtest basic-hwmon: SKIP (0.000s)
[38.439526] [005/171] (958s left) fbdev (eof)
[38.568905] Starting subtest: eof
[38.570124] Subtest eof: SUCCESS (0.000s)
[38.624290] [006/171] (957s left) fbdev (info)
[38.743402] Starting subtest: info
[38.744539] Subtest info: SUCCESS (0.000s)
[38.808425] [007/171] (957s left) fbdev (nullptr)
[38.933759] Starting subtest: nullptr
[38.935846] Subtest nullptr: SUCCESS (0.000s)
[38.990846] [008/171] (957s left) fbdev (read)
[39.117819] Starting subtest: read
[39.363229] Subtest read: SUCCESS (0.245s)
[39.427163] [009/171] (957s left) fbdev (write)
[39.569386] Starting subtest: write
[39.719099] Subtest write: SUCCESS (0.148s)
[39.776933] [010/171] (956s left) gem_basic (bad-close)
[39.905284] Starting subtest: bad-close
[39.907394] Subtest bad-close: SUCCESS (0.000s)
[39.978625] [011/171] (956s left) gem_basic (create-close)
[40.098890] Starting subtest: create-close
[40.101606] Subtest create-close: SUCCESS (0.000s)
[40.163739] [012/171] (956s left) gem_basic (create-fd-close)
[40.286202] Starting subtest: create-fd-close
[40.289048] Subtest create-fd-close: SUCCESS (0.001s)
[40.364049] [013/171] (956s left) gem_busy (busy@all-engines)
[40.501841] Starting subtest: busy
[40.506938] Starting dynamic subtest: all-engines
[40.527236] Dynamic subtest all-engines: SUCCESS (0.025s)
[40.528260] Subtest busy: SUCCESS (0.025s)
[40.849314] [014/171] (955s left) gem_close_race (basic-process)
[40.986830] Starting subtest: basic-process
[41.030460] Subtest basic-process: SUCCESS (0.044s)
[41.217526] [015/171] (955s left) gem_close_race (basic-threads)
[41.355754] Starting subtest: basic-threads
[42.480554] Subtest basic-threads: SUCCESS (1.127s)
[42.655676] [016/171] (954s left) gem_ctx_create (basic)
[42.785822] Subtest basic: SKIP (0.000s)
[42.806702] [017/171] (953s left) gem_ctx_create (basic-files)
[42.932970] Subtest basic-files: SKIP (0.000s)
[42.958511] [018/171] (953s left) gem_ctx_exec (basic)
[43.085722] Subtest basic: SKIP (0.000s)
[43.160658] [019/171] (953s left) gem_exec_basic (basic)
[43.287341] Starting subtest: basic
[43.288369] Starting dynamic subtest: rcs0-smem
[43.289486] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[43.290602] Subtest basic: SUCCESS (0.002s)
[43.475053] [020/171] (953s left) gem_exec_create (basic)
[43.606291] Starting subtest: basic
[43.607409] Starting dynamic subtest: smem
[45.636319] Dynamic subtest smem: SUCCESS (2.032s)
[45.637396] Subtest basic: SUCCESS (2.032s)
[45.818064] [021/171] (950s left) gem_exec_fence (basic-busy)
[46.072814] Starting subtest: basic-busy
[46.073879] Starting dynamic subtest: rcs0
[46.081313] Dynamic subtest rcs0: SUCCESS (0.010s)
[46.082280] Subtest basic-busy: SUCCESS (0.011s)
[46.568835] [022/171] (950s left) gem_exec_fence (basic-wait)
[46.826075] Starting subtest: basic-wait
[46.827134] Starting dynamic subtest: rcs0
[46.836246] Dynamic subtest rcs0: SUCCESS (0.011s)
[46.837256] Subtest basic-wait: SUCCESS (0.012s)
[47.272394] [023/171] (949s left) gem_exec_fence (basic-await)
[47.528656] Starting subtest: basic-await
[47.529826] Starting dynamic subtest: rcs0
[47.590647] Dynamic subtest rcs0: SUCCESS (0.062s)
[47.591893] Subtest basic-await: SUCCESS (0.062s)
[48.024407] [024/171] (948s left) gem_exec_fence (nb-await)
[48.281152] Starting subtest: nb-await
[48.282253] Starting dynamic subtest: rcs0
[48.331712] Dynamic subtest rcs0: SUCCESS (0.052s)
[48.333266] Subtest nb-await: SUCCESS (0.053s)
[48.769837] [025/171] (948s left) gem_exec_gttfill (basic)
[48.901521] Starting subtest: basic
[52.197277] Subtest basic: SUCCESS (3.294s)
[52.373466] [026/171] (944s left) gem_exec_parallel (engines)
[52.629377] Starting subtest: engines
[52.630453] Starting dynamic subtest: basic
[54.425451] Dynamic subtest basic: SUCCESS (1.795s)
[54.434909] Starting dynamic subtest: contexts
[54.437861] Dynamic subtest contexts: SKIP (0.000s)
[54.446307] Starting dynamic subtest: fds
[54.448405] Dynamic subtest fds: SKIP (0.000s)
[54.455853] Starting dynamic subtest: userptr
[56.290374] Dynamic subtest userptr: SUCCESS (1.863s)
[56.291503] Subtest engines: SUCCESS (3.662s)
[56.474355] [027/171] (940s left) gem_exec_store (basic)
[56.611074] Starting subtest: basic
[56.636677] Subtest basic: SUCCESS (0.024s)
[56.823013] [028/171] (940s left) gem_flink_basic (bad-flink)
[56.941226] Starting subtest: bad-flink
[56.942291] Subtest bad-flink: SUCCESS (0.000s)
[57.005391] [029/171] (939s left) gem_flink_basic (bad-open)
[57.126862] Starting subtest: bad-open
[57.130063] Subtest bad-open: SUCCESS (0.000s)
[57.189050] [030/171] (939s left) gem_flink_basic (basic)
[57.308285] Starting subtest: basic
[57.309340] Subtest basic: SUCCESS (0.000s)
[57.375006] [031/171] (939s left) gem_flink_basic (double-flink)
[57.495974] Starting subtest: double-flink
[57.497030] Subtest double-flink: SUCCESS (0.000s)
[57.574139] [032/171] (939s left) gem_flink_basic (flink-lifetime)
[57.702740] Starting subtest: flink-lifetime
[57.703854] Subtest flink-lifetime: SUCCESS (0.001s)
[57.774892] [033/171] (939s left) gem_huc_copy (huc-copy)
[57.895461] Subtest huc-copy: SKIP (0.000s)
[57.926222] [034/171] (939s left) gem_linear_blits (basic)
[58.316209] Starting subtest: basic
[58.328543] Subtest basic: SUCCESS (0.012s)
[58.441889] [035/171] (938s left) gem_mmap (basic)
[58.692963] Starting subtest: basic
[58.698434] Subtest basic: SUCCESS (0.001s)
[58.761147] [036/171] (938s left) gem_mmap_gtt (basic)
[58.892151] Starting subtest: basic
[58.893126] Subtest basic: SUCCESS (0.001s)
[58.968617] [037/171] (938s left) gem_render_linear_blits (basic)
[59.094321] Starting subtest: basic
[59.139573] Subtest basic: SUCCESS (0.048s)
[59.181150] [038/171] (937s left) gem_render_tiled_blits (basic)
[59.308152] Starting subtest: basic
[59.344391] Subtest basic: SUCCESS (0.041s)
[59.381819] [039/171] (937s left) gem_ringfill (basic-all)
[59.529330] Starting subtest: basic-all
[60.634638] Subtest basic-all: SUCCESS (1.105s)
[60.702600] [040/171] (936s left) gem_softpin (allocator-basic)
[60.828061] Subtest allocator-basic: SKIP (0.000s)
[60.901367] [041/171] (936s left) gem_softpin (allocator-basic-reserve)
[61.027084] Subtest allocator-basic-reserve: SKIP (0.000s)
[61.085347] [042/171] (936s left) gem_softpin (safe-alignment)
[61.211139] Starting subtest: safe-alignment
[61.213693] Subtest safe-alignment: SUCCESS (0.006s)
[61.287112] [043/171] (935s left) gem_sync (basic-all)
[61.420513] Starting subtest: basic-all
[63.460124] Subtest basic-all: SUCCESS (2.038s)
[63.645525] [044/171] (933s left) gem_sync (basic-each)
[63.781300] Starting subtest: basic-each
[65.900174] Subtest basic-each: SUCCESS (2.119s)
[66.086679] [045/171] (931s left) gem_tiled_blits (basic)
[66.479947] Starting subtest: basic
[66.502126] Subtest basic: SUCCESS (0.021s)
[66.604372] [046/171] (930s left) gem_tiled_fence_blits (basic)
[67.143503] Starting subtest: basic
[67.157443] Subtest basic: SUCCESS (0.013s)
[67.255912] [047/171] (930s left) gem_tiled_pread_basic
[67.758509] [048/171] (929s left) gem_wait (busy@all-engines)
[67.898287] Starting subtest: busy
[67.899686] Starting dynamic subtest: all-engines
[68.409135] Dynamic subtest all-engines: SUCCESS (0.511s)
[68.410241] Subtest busy: SUCCESS (0.511s)
[68.615239] [049/171] (928s left) gem_wait (wait@all-engines)
[68.752019] Starting subtest: wait
[68.753898] Starting dynamic subtest: all-engines
[69.765203] Dynamic subtest all-engines: SUCCESS (1.013s)
[69.766323] Subtest wait: SUCCESS (1.013s)
[69.966378] [050/171] (927s left) i915_getparams_basic (basic-eu-total)
[70.088385] Starting subtest: basic-eu-total
[70.091164] Subtest basic-eu-total: SUCCESS (0.000s)
[70.150705] [051/171] (927s left) i915_getparams_basic (basic-subslice-total)
[70.271309] Starting subtest: basic-subslice-total
[70.274042] Subtest basic-subslice-total: SUCCESS (0.000s)
[70.334314] [052/171] (927s left) i915_hangman (error-state-basic)
[70.461139] Starting subtest: error-state-basic
[70.577487] Subtest error-state-basic: SUCCESS (0.120s)
[70.633509] [053/171] (926s left) i915_pciid
[70.831477] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[70.966539] Starting subtest: addfb25-bad-modifier
[70.968438] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[71.082716] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[71.209919] Starting subtest: addfb25-framebuffer-vs-set-tiling
[71.211042] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[71.316578] [056/171] (926s left) kms_addfb_basic (addfb25-modifier-no-flag)
[71.448047] Starting subtest: addfb25-modifier-no-flag
[71.449097] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[71.535302] [057/171] (925s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[71.663345] Starting subtest: addfb25-x-tiled-legacy
[71.664430] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[71.767056] [058/171] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[71.889233] Starting subtest: addfb25-x-tiled-mismatch-legacy
[71.890320] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[72.002288] [059/171] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[72.144435] Starting subtest: addfb25-yf-tiled-legacy
[72.145613] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[72.218935] [060/171] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[72.379940] Starting subtest: addfb25-y-tiled-legacy
[72.381338] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[72.452913] [061/171] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[72.594875] Starting subtest: addfb25-y-tiled-small-legacy
[72.597200] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[72.670810] [062/171] (924s left) kms_addfb_basic (bad-pitch-0)
[72.796518] Starting subtest: bad-pitch-0
[72.799025] Subtest bad-pitch-0: SUCCESS (0.000s)
[72.889033] [063/171] (924s left) kms_addfb_basic (bad-pitch-1024)
[73.016024] Starting subtest: bad-pitch-1024
[73.017275] Subtest bad-pitch-1024: SUCCESS (0.000s)
[73.122974] [064/171] (924s left) kms_addfb_basic (bad-pitch-128)
[73.250888] Starting subtest: bad-pitch-128
[73.251955] Subtest bad-pitch-128: SUCCESS (0.000s)
[73.359073] [065/171] (924s left) kms_addfb_basic (bad-pitch-256)
[73.486840] Starting subtest: bad-pitch-256
[73.487967] Subtest bad-pitch-256: SUCCESS (0.000s)
[73.590892] [066/171] (924s left) kms_addfb_basic (bad-pitch-32)
[73.716433] Starting subtest: bad-pitch-32
[73.717651] Subtest bad-pitch-32: SUCCESS (0.000s)
[73.809925] [067/171] (923s left) kms_addfb_basic (bad-pitch-63)
[73.936176] Starting subtest: bad-pitch-63
[73.937087] Subtest bad-pitch-63: SUCCESS (0.000s)
[74.042400] [068/171] (923s left) kms_addfb_basic (bad-pitch-65536)
[74.165176] Starting subtest: bad-pitch-65536
[74.166389] Subtest bad-pitch-65536: SUCCESS (0.000s)
[74.276410] [069/171] (923s left) kms_addfb_basic (bad-pitch-999)
[74.402401] Starting subtest: bad-pitch-999
[74.403619] Subtest bad-pitch-999: SUCCESS (0.000s)
[74.501297] [070/171] (923s left) kms_addfb_basic (basic)
[74.627538] Starting subtest: basic
[74.628709] Subtest basic: SUCCESS (0.000s)
[74.734159] [071/171] (923s left) kms_addfb_basic (basic-x-tiled-legacy)
[74.859810] Starting subtest: basic-x-tiled-legacy
[74.860861] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[74.963130] [072/171] (922s left) kms_addfb_basic (basic-y-tiled-legacy)
[75.089996] Starting subtest: basic-y-tiled-legacy
[75.091112] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[75.196595] [073/171] (922s left) kms_addfb_basic (bo-too-small)
[75.337987] Starting subtest: bo-too-small
[75.339168] Subtest bo-too-small: SUCCESS (0.000s)
[75.413744] [074/171] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[75.555347] Starting subtest: bo-too-small-due-to-tiling
[75.556646] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[75.630302] [075/171] (922s left) kms_addfb_basic (clobberred-modifier)
[75.758643] Starting subtest: clobberred-modifier
[75.759775] Subtest clobberred-modifier: SUCCESS (0.000s)
[75.850322] [076/171] (922s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[75.976071] Starting subtest: framebuffer-vs-set-tiling
[75.977038] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[76.083286] [077/171] (921s left) kms_addfb_basic (invalid-get-prop)
[76.207113] Starting subtest: invalid-get-prop
[76.208324] Subtest invalid-get-prop: SUCCESS (0.000s)
[76.300564] [078/171] (921s left) kms_addfb_basic (invalid-get-prop-any)
[76.427310] Starting subtest: invalid-get-prop-any
[76.428441] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[76.518793] [079/171] (921s left) kms_addfb_basic (invalid-set-prop)
[76.640935] Starting subtest: invalid-set-prop
[76.642042] Subtest invalid-set-prop: SUCCESS (0.000s)
[76.750830] [080/171] (921s left) kms_addfb_basic (invalid-set-prop-any)
[76.874757] Starting subtest: invalid-set-prop-any
[76.876287] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[76.969416] [081/171] (921s left) kms_addfb_basic (no-handle)
[77.096658] Starting subtest: no-handle
[77.097801] Subtest no-handle: SUCCESS (0.000s)
[77.204160] [082/171] (920s left) kms_addfb_basic (size-max)
[77.345261] Starting subtest: size-max
[77.347000] Subtest size-max: SUCCESS (0.000s)
[77.422648] [083/171] (920s left) kms_addfb_basic (small-bo)
[77.581343] Starting subtest: small-bo
[77.582437] Subtest small-bo: SUCCESS (0.000s)
[77.653680] [084/171] (920s left) kms_addfb_basic (tile-pitch-mismatch)
[77.780239] Starting subtest: tile-pitch-mismatch
[77.781251] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[77.873750] [085/171] (920s left) kms_addfb_basic (too-high)
[78.032487] Starting subtest: too-high
[78.033676] Subtest too-high: SUCCESS (0.002s)
[78.105259] [086/171] (920s left) kms_addfb_basic (too-wide)
[78.250204] Starting subtest: too-wide
[78.251304] Subtest too-wide: SUCCESS (0.000s)
[78.322573] [087/171] (919s left) kms_addfb_basic (unused-handle)
[78.448283] Starting subtest: unused-handle
[78.449730] Subtest unused-handle: SUCCESS (0.000s)
[78.541227] [088/171] (919s left) kms_addfb_basic (unused-modifier)
[78.667783] Starting subtest: unused-modifier
[78.669017] Subtest unused-modifier: SUCCESS (0.000s)
[78.758668] [089/171] (919s left) kms_addfb_basic (unused-offsets)
[78.884142] Starting subtest: unused-offsets
[78.885182] Subtest unused-offsets: SUCCESS (0.000s)
[78.993396] [090/171] (919s left) kms_addfb_basic (unused-pitches)
[79.119121] Starting subtest: unused-pitches
[79.120237] Subtest unused-pitches: SUCCESS (0.000s)
[79.210682] [091/171] (919s left) kms_busy (basic)
[79.370092] Starting subtest: basic
[79.372400] Starting dynamic subtest: flip
[79.959172] Dynamic subtest flip: SUCCESS (0.587s)
[79.970204] Starting dynamic subtest: modeset
[79.980531] Dynamic subtest modeset: SKIP (0.000s)
[79.988041] Subtest basic: SUCCESS (0.600s)
[80.068260] [092/171] (918s left) kms_chamelium_hpd (dp-hpd-fast)
[80.226447] Subtest dp-hpd-fast: SKIP (0.000s)
[80.267001] [093/171] (918s left) kms_chamelium_edid (dp-edid-read)
[80.422343] Subtest dp-edid-read: SKIP (0.000s)
[80.467184] [094/171] (917s left) kms_chamelium_frames (dp-crc-fast)
[80.624329] Subtest dp-crc-fast: SKIP (0.000s)
[80.668232] [095/171] (917s left) kms_chamelium_hpd (hdmi-hpd-fast)
[80.825776] Subtest hdmi-hpd-fast: SKIP (0.000s)
[80.868917] [096/171] (917s left) kms_chamelium_edid (hdmi-edid-read)
[81.025541] Subtest hdmi-edid-read: SKIP (0.000s)
[81.069952] [097/171] (917s left) kms_chamelium_frames (hdmi-crc-fast)
[81.226063] Subtest hdmi-crc-fast: SKIP (0.000s)
[81.270157] [098/171] (917s left) kms_chamelium_hpd (vga-hpd-fast)
[81.429528] Subtest vga-hpd-fast: SKIP (0.000s)
[81.471197] [099/171] (916s left) kms_chamelium_edid (vga-edid-read)
[81.626236] Subtest vga-edid-read: SKIP (0.000s)
[81.671528] [100/171] (916s left) kms_prop_blob (basic)
[81.794949] Starting subtest: basic
[81.796080] Subtest basic: SUCCESS (0.000s)
[81.855056] [101/171] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[82.015324] Starting subtest: basic-busy-flip-before-cursor-atomic
[82.019412] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.005s)
[82.087571] [102/171] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[82.236429] Starting subtest: basic-busy-flip-before-cursor-legacy
[83.246441] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.011s)
[83.356078] [103/171] (915s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[83.513815] Starting subtest: basic-flip-after-cursor-atomic
[83.516094] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[83.588668] [104/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[83.731301] Starting subtest: basic-flip-after-cursor-legacy
[84.733343] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.001s)
[84.844757] [105/171] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[85.000855] Starting subtest: basic-flip-after-cursor-varying-size
[86.008090] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.005s)
[86.126203] [106/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[86.284724] Starting subtest: basic-flip-before-cursor-atomic
[86.287286] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[86.358938] [107/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[86.518079] Starting subtest: basic-flip-before-cursor-legacy
[87.523267] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.005s)
[87.645411] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[87.802586] Starting subtest: basic-flip-before-cursor-varying-size
[88.806492] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.004s)
[88.931849] [109/171] (909s left) kms_flip (basic-flip-vs-dpms)
[89.089185] Starting subtest: basic-flip-vs-dpms
[89.090250] Starting dynamic subtest: A-VGA1
[90.383865] Dynamic subtest A-VGA1: SUCCESS (1.293s)
[90.400534] Starting dynamic subtest: B-VGA1
[91.629386] Dynamic subtest B-VGA1: SUCCESS (1.235s)
[91.630341] Subtest basic-flip-vs-dpms: SUCCESS (2.530s)
[91.787726] [110/171] (906s left) kms_flip (basic-flip-vs-modeset)
[91.944729] Starting subtest: basic-flip-vs-modeset
[91.945904] Starting dynamic subtest: A-VGA1
[93.247042] Dynamic subtest A-VGA1: SUCCESS (1.292s)
[93.265906] Starting dynamic subtest: B-VGA1
[94.436570] Dynamic subtest B-VGA1: SUCCESS (1.189s)
[94.437642] Subtest basic-flip-vs-modeset: SUCCESS (2.493s)
[94.577422] [111/171] (904s left) kms_flip (basic-flip-vs-wf_vblank)
[94.736169] Starting subtest: basic-flip-vs-wf_vblank
[94.737284] Starting dynamic subtest: A-VGA1
[96.291181] Dynamic subtest A-VGA1: SUCCESS (1.543s)
[96.316840] Starting dynamic subtest: B-VGA1
[97.816736] Dynamic subtest B-VGA1: SUCCESS (1.513s)
[97.823644] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.068s)
[97.991450] [112/171] (900s left) kms_flip (basic-plain-flip)
[98.150901] Starting subtest: basic-plain-flip
[98.152108] Starting dynamic subtest: A-VGA1
[99.422037] Dynamic subtest A-VGA1: SUCCESS (1.263s)
[99.441928] Starting dynamic subtest: B-VGA1
[100.657816] Dynamic subtest B-VGA1: SUCCESS (1.229s)
[100.665040] Subtest basic-plain-flip: SUCCESS (2.511s)
[100.837910] [113/171] (897s left) kms_force_connector_basic (force-connector-state)
[101.060070] Starting subtest: force-connector-state
[101.228706] Subtest force-connector-state: SUCCESS (0.168s)
[101.462404] [114/171] (897s left) kms_force_connector_basic (force-edid)
[101.686376] Starting subtest: force-edid
[101.801977] Subtest force-edid: SUCCESS (0.116s)
[102.013120] [115/171] (896s left) kms_force_connector_basic (force-load-detect)
[102.224601] Starting subtest: force-load-detect
[102.387282] Subtest force-load-detect: SUCCESS (0.160s)
[102.587919] [116/171] (896s left) kms_force_connector_basic (prune-stale-modes)
[102.796391] Starting subtest: prune-stale-modes
[102.895765] Subtest prune-stale-modes: SUCCESS (0.099s)
[103.106620] [117/171] (895s left) kms_frontbuffer_tracking (basic)
[103.268060] Subtest basic: SKIP (0.000s)
[103.309697] [118/171] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[103.467859] Starting subtest: compare-crc-sanitycheck-xr24
[103.468995] Starting dynamic subtest: pipe-A-VGA-1
[103.776598] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.298s)
[103.800415] Starting dynamic subtest: pipe-B-VGA-1
[104.120601] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.319s)
[104.121572] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.652s)
[104.246983] [119/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[104.404900] Starting subtest: compare-crc-sanitycheck-nv12
[104.407233] Starting dynamic subtest: pipe-A-VGA-1
[104.409384] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[104.419608] Starting dynamic subtest: pipe-B-VGA-1
[104.422239] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[104.424347] Subtest compare-crc-sanitycheck-nv12: SKIP (0.005s)
[104.486616] [120/171] (894s left) kms_pipe_crc_basic (hang-read-crc)
[104.639056] Starting subtest: hang-read-crc
[104.641252] Starting dynamic subtest: pipe-A-VGA-1
[105.591352] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.950s)
[105.602850] Starting dynamic subtest: pipe-B-VGA-1
[106.555327] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.962s)
[106.556421] Subtest hang-read-crc: SUCCESS (1.917s)
[106.675998] [121/171] (892s left) kms_pipe_crc_basic (nonblocking-crc)
[106.831443] Starting subtest: nonblocking-crc
[106.834018] Starting dynamic subtest: pipe-A-VGA-1
[107.353875] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.519s)
[107.366903] Starting dynamic subtest: pipe-B-VGA-1
[107.872384] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.517s)
[107.873581] Subtest nonblocking-crc: SUCCESS (1.041s)
[107.992169] [122/171] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[108.148971] Starting subtest: nonblocking-crc-frame-sequence
[108.150205] Starting dynamic subtest: pipe-A-VGA-1
[108.634763] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.484s)
[108.649906] Starting dynamic subtest: pipe-B-VGA-1
[109.142430] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.505s)
[109.143619] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.994s)
[109.261318] [123/171] (889s left) kms_pipe_crc_basic (read-crc)
[109.419993] Starting subtest: read-crc
[109.421200] Starting dynamic subtest: pipe-A-VGA-1
[109.871836] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.449s)
[109.881848] Starting dynamic subtest: pipe-B-VGA-1
[110.307164] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.434s)
[110.308281] Subtest read-crc: SUCCESS (0.888s)
[110.423473] [124/171] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[110.581777] Starting subtest: read-crc-frame-sequence
[110.582886] Starting dynamic subtest: pipe-A-VGA-1
[111.017855] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.434s)
[111.030885] Starting dynamic subtest: pipe-B-VGA-1
[111.495499] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.475s)
[111.496689] Subtest read-crc-frame-sequence: SUCCESS (0.914s)
[111.616034] [125/171] (887s left) kms_psr (primary_page_flip)
[111.743436] Subtest primary_page_flip: SKIP (0.000s)
[111.786446] [126/171] (887s left) kms_psr (cursor_plane_move)
[111.909737] Subtest cursor_plane_move: SKIP (0.000s)
[111.953486] [127/171] (887s left) kms_psr (sprite_plane_onoff)
[112.076952] Subtest sprite_plane_onoff: SKIP (0.000s)
[112.123120] [128/171] (886s left) kms_psr (primary_mmap_gtt)
[112.246318] Subtest primary_mmap_gtt: SKIP (0.000s)
[112.287762] [129/171] (886s left) kms_setmode (basic-clone-single-crtc)
[112.413575] Starting subtest: basic-clone-single-crtc
[112.416977] Subtest basic-clone-single-crtc: SKIP (0.000s)
[112.485376] [130/171] (886s left) i915_pm_backlight (basic-brightness)
[112.644430] Subtest basic-brightness: SKIP (0.000s)
[112.689164] [131/171] (886s left) i915_pm_rpm (basic-pci-d3-state)
[123.996056] Subtest basic-pci-d3-state: SKIP (0.000s)
[124.028227] [132/171] (875s left) i915_pm_rpm (basic-rte)
[124.147644] Starting subtest: basic-rte
[135.345085] Subtest basic-rte: SKIP (11.181s)
[135.366443] [133/171] (863s left) i915_pm_rps (basic-api)
[135.497505] Subtest basic-api: SKIP (0.000s)
[135.518234] [134/171] (863s left) prime_self_import (basic-llseek-bad)
[135.640853] Starting subtest: basic-llseek-bad
[135.643119] Subtest basic-llseek-bad: SUCCESS (0.003s)
[135.717202] [135/171] (863s left) prime_self_import (basic-llseek-size)
[135.836207] Starting subtest: basic-llseek-size
[135.840290] Subtest basic-llseek-size: SUCCESS (0.006s)
[135.917344] [136/171] (863s left) prime_self_import (basic-with_fd_dup)
[136.038136] Starting subtest: basic-with_fd_dup
[136.040415] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[136.118761] [137/171] (863s left) prime_self_import (basic-with_one_bo)
[136.239817] Starting subtest: basic-with_one_bo
[136.242177] Subtest basic-with_one_bo: SUCCESS (0.004s)
[136.322475] [138/171] (862s left) prime_self_import (basic-with_one_bo_two_files)
[136.445028] Starting subtest: basic-with_one_bo_two_files
[136.447439] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[136.519430] [139/171] (862s left) prime_self_import (basic-with_two_bos)
[136.641870] Starting subtest: basic-with_two_bos
[136.644616] Subtest basic-with_two_bos: SUCCESS (0.003s)
[136.721037] [140/171] (862s left) prime_vgem (basic-fence-flip)
[136.852825] Starting subtest: basic-fence-flip
[137.247110] Subtest basic-fence-flip: SUCCESS (0.399s)
[137.339903] [141/171] (861s left) prime_vgem (basic-fence-mmap)
[137.472041] Starting subtest: basic-fence-mmap
[137.508779] Subtest basic-fence-mmap: SUCCESS (0.043s)
[137.590505] [142/171] (861s left) prime_vgem (basic-fence-read)
[137.722756] Starting subtest: basic-fence-read
[137.781724] Subtest basic-fence-read: SUCCESS (0.064s)
[137.858351] [143/171] (861s left) prime_vgem (basic-gtt)
[137.988382] Starting subtest: basic-gtt
[138.003495] Subtest basic-gtt: SUCCESS (0.017s)
[138.074556] [144/171] (861s left) prime_vgem (basic-read)
[138.208537] Starting subtest: basic-read
[138.232401] Subtest basic-read: SUCCESS (0.029s)
[138.310000] [145/171] (861s left) prime_vgem (basic-write)
[138.441831] Starting subtest: basic-write
[138.467643] Subtest basic-write: SUCCESS (0.031s)
[138.544195] [146/171] (860s left) vgem_basic (setversion)
[138.667183] Starting subtest: setversion
[138.669854] Subtest setversion: SUCCESS (0.000s)
[138.729469] [147/171] (860s left) vgem_basic (create)
[138.853204] Starting subtest: create
[138.854340] Subtest create: SUCCESS (0.000s)
[138.910291] [148/171] (860s left) vgem_basic (debugfs)
[139.036818] Starting subtest: debugfs
[139.037969] Subtest debugfs: SUCCESS (0.001s)
[139.095810] [149/171] (860s left) vgem_basic (dmabuf-export)
[139.219291] Starting subtest: dmabuf-export
[139.223309] Subtest dmabuf-export: SUCCESS (0.003s)
[139.296215] [150/171] (860s left) vgem_basic (dmabuf-fence)
[139.420926] Starting subtest: dmabuf-fence
[139.422108] Subtest dmabuf-fence: SUCCESS (0.001s)
[139.479489] [151/171] (860s left) vgem_basic (dmabuf-fence-before)
[139.604862] Starting subtest: dmabuf-fence-before
[139.605905] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[139.663911] [152/171] (859s left) vgem_basic (dmabuf-mmap)
[139.788372] Starting subtest: dmabuf-mmap
[139.808968] Subtest dmabuf-mmap: SUCCESS (0.021s)
[139.865073] [153/171] (859s left) vgem_basic (mmap)
[139.989171] Starting subtest: mmap
[140.002267] Subtest mmap: SUCCESS (0.014s)
[140.047741] [154/171] (859s left) vgem_basic (second-client)
[140.172406] Starting subtest: second-client
[140.207420] Subtest second-client: SUCCESS (0.033s)
[140.264458] [155/171] (859s left) vgem_basic (sysfs)
[140.390985] Starting subtest: sysfs
[140.392151] Subtest sysfs: SUCCESS (0.001s)
[140.450395] [156/171] (859s left) core_hotunplug (unbind-rebind)
[140.623109] Starting subtest: unbind-rebind
[141.412720] Subtest unbind-rebind: SUCCESS (0.789s)
[141.442387] [157/171] (858s left) vgem_basic (unload)
[141.621685] Starting subtest: unload
[170.542801] Subtest unload: SUCCESS (28.919s)
[170.640462] [158/171] (829s left) i915_module_load (reload)
[170.759815] Starting subtest: reload
[172.742849] Subtest reload: SUCCESS (1.974s)
[172.768473] [159/171] (826s left) gem_lmem_swapping (basic)
[172.927812] Subtest basic: SKIP (0.000s)
[172.962491] [160/171] (826s left) gem_lmem_swapping (parallel-random-engines)
[173.122737] Subtest parallel-random-engines: SKIP (0.000s)
[173.176453] [161/171] (826s left) gem_lmem_swapping (random-engines)
[173.365662] Subtest random-engines: SKIP (0.000s)
[173.397481] [162/171] (826s left) gem_lmem_swapping (verify-random)
[173.522529] Subtest verify-random: SKIP (0.000s)
[173.547727] [163/171] (826s left) i915_pm_rpm (module-reload)
[184.866051] Subtest module-reload: SKIP (0.000s)
[184.886490] [164/171] (815s left) i915_selftest (live)
[185.664038] Starting subtest: live
[185.665121] Starting dynamic subtest: sanitycheck
[186.418825] Dynamic subtest sanitycheck: SUCCESS (0.756s)
[186.430042] Starting dynamic subtest: uncore
[187.042476] Dynamic subtest uncore: SUCCESS (0.622s)
[187.050960] Starting dynamic subtest: workarounds
[187.679040] Dynamic subtest workarounds: SUCCESS (0.635s)
[187.689560] Starting dynamic subtest: gt_engines
[188.298697] Dynamic subtest gt_engines: SUCCESS (0.619s)
[188.309160] Starting dynamic subtest: gt_timelines
[191.148815] Dynamic subtest gt_timelines: SUCCESS (2.845s)
[191.156744] Starting dynamic subtest: gt_contexts
[191.795132] Dynamic subtest gt_contexts: SUCCESS (0.648s)
[191.805169] Starting dynamic subtest: gt_lrc
[192.426112] Dynamic subtest gt_lrc: SUCCESS (0.630s)
[192.435097] Starting dynamic subtest: gt_mocs
[193.062676] Dynamic subtest gt_mocs: SUCCESS (0.635s)
[193.073474] Starting dynamic subtest: gt_pm
[194.183979] Dynamic subtest gt_pm: SUCCESS (1.117s)
[194.192869] Starting dynamic subtest: gt_heartbeat
[194.868891] Dynamic subtest gt_heartbeat: SUCCESS (0.685s)
[194.879490] Starting dynamic subtest: gt_tlb
[195.519629] Dynamic subtest gt_tlb: SUCCESS (0.650s)
[195.529921] Starting dynamic subtest: requests
[198.734328] Dynamic subtest requests: SUCCESS (3.211s)
[198.742183] Starting dynamic subtest: migrate
[199.395786] Dynamic subtest migrate: SUCCESS (0.662s)
[199.406801] Starting dynamic subtest: active
[200.035836] Dynamic subtest active: SUCCESS (0.638s)
[200.044931] Starting dynamic subtest: objects
[201.019099] Dynamic subtest objects: SUCCESS (0.979s)
[201.028703] Starting dynamic subtest: mman
[205.909058] Dynamic subtest mman: SUCCESS (4.888s)
[205.919874] Starting dynamic subtest: dmabuf
[206.605864] Dynamic subtest dmabuf: SUCCESS (0.696s)
[206.616116] Starting dynamic subtest: vma
[207.240976] Dynamic subtest vma: SUCCESS (0.633s)
[207.251827] Starting dynamic subtest: coherency
[208.984192] Dynamic subtest coherency: SUCCESS (1.741s)
[208.994296] Starting dynamic subtest: gtt
[213.135077] Dynamic subtest gtt: SUCCESS (4.151s)
[213.145456] Starting dynamic subtest: gem
[213.776670] Dynamic subtest gem: SUCCESS (0.641s)
[213.788069] Starting dynamic subtest: evict
[214.426052] Dynamic subtest evict: SUCCESS (0.647s)
[214.436272] Starting dynamic subtest: hugepages
[215.039787] Dynamic subtest hugepages: SUCCESS (0.613s)
[215.051275] Starting dynamic subtest: gem_contexts
[215.681575] Dynamic subtest gem_contexts: SUCCESS (0.640s)
[215.692290] Starting dynamic subtest: client
[216.333930] Dynamic subtest client: SUCCESS (0.651s)
[216.346069] Starting dynamic subtest: gem_migrate
[216.947150] Dynamic subtest gem_migrate: SUCCESS (0.611s)
[216.955997] Starting dynamic subtest: reset
[217.970239] Dynamic subtest reset: SUCCESS (1.021s)
[217.980266] Starting dynamic subtest: memory_region
[218.641937] Dynamic subtest memory_region: SUCCESS (0.671s)
[218.652890] Starting dynamic subtest: hangcheck
[220.293304] Dynamic subtest hangcheck: SUCCESS (1.649s)
[220.304729] Starting dynamic subtest: execlists
[220.913687] Dynamic subtest execlists: SUCCESS (0.618s)
[220.924892] Starting dynamic subtest: ring_submission
[221.546589] Dynamic subtest ring_submission: SUCCESS (0.632s)
[221.555110] Starting dynamic subtest: perf
[222.186251] Dynamic subtest perf: SUCCESS (0.637s)
[222.194996] Starting dynamic subtest: slpc
[222.800622] Dynamic subtest slpc: SUCCESS (0.613s)
[222.807600] Starting dynamic subtest: guc
[223.439364] Dynamic subtest guc: SUCCESS (0.637s)
[223.449980] Starting dynamic subtest: guc_multi_lrc
[224.080407] Dynamic subtest guc_multi_lrc: SUCCESS (0.638s)
[224.090552] Starting dynamic subtest: guc_hang
[224.723973] Dynamic subtest guc_hang: SUCCESS (0.641s)
[224.734364] Starting dynamic subtest: late_gt_pm
[225.379951] Dynamic subtest late_gt_pm: SUCCESS (0.653s)
[225.381420] Subtest live: SUCCESS (39.719s)
[225.524872] [165/171] (774s left) dmabuf (all-tests)
[225.649399] Starting subtest: all-tests
[225.654705] Starting dynamic subtest: sanitycheck
[225.713554] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[225.722056] Starting dynamic subtest: dma_fence
[225.898189] Dynamic subtest dma_fence: SUCCESS (0.185s)
[225.917856] Starting dynamic subtest: dma_fence_chain
[243.206379] Dynamic subtest dma_fence_chain: SUCCESS (17.303s)
[243.220178] Starting dynamic subtest: dma_fence_unwrap
[243.268418] Dynamic subtest dma_fence_unwrap: SUCCESS (0.065s)
[243.288138] Starting dynamic subtest: dma_resv
[243.328186] Dynamic subtest dma_resv: SUCCESS (0.057s)
[243.329811] Subtest all-tests: SUCCESS (17.680s)
[243.347845] [166/171] (756s left) i915_suspend (basic-s2idle-without-i915)
[243.465360] Starting subtest: basic-s2idle-without-i915
[261.467286] Subtest basic-s2idle-without-i915: SUCCESS (18.004s)
[264.116694] [167/171] (738s left) i915_suspend (basic-s3-without-i915)
[264.242493] Starting subtest: basic-s3-without-i915
[281.149356] Subtest basic-s3-without-i915: SUCCESS (2.218s)
[283.770300] [168/171] (736s left) gem_exec_suspend (basic-s0)
[283.915487] Starting subtest: basic-S0
[283.917942] Starting dynamic subtest: smem
[300.961505] Dynamic subtest smem: SUCCESS (17.045s)
[300.962546] Subtest basic-S0: SUCCESS (17.046s)
[306.153245] [169/171] (718s left) gem_exec_suspend (basic-s3)
[306.288527] Starting subtest: basic-S3
[306.290849] Starting dynamic subtest: smem
[323.875120] Dynamic subtest smem: SUCCESS (1.865s)
[323.876291] Subtest basic-S3: SUCCESS (1.868s)
[329.071132] [170/171] (716s left) kms_chamelium_hpd (common-hpd-after-suspend)
[329.221406] Subtest common-hpd-after-suspend: SKIP (0.000s)
[329.268986] [171/171] (716s left) kms_pipe_crc_basic (suspend-read-crc)
[329.425911] Starting subtest: suspend-read-crc
[329.426986] Starting dynamic subtest: pipe-A-VGA-1
[346.991553] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.756s)
[347.011039] Starting dynamic subtest: pipe-B-VGA-1
[365.035553] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.875s)
[365.037011] Subtest suspend-read-crc: SUCCESS (3.644s)
[368.183241] Closing watchdogs
Done.