[39.769688] Initializing watchdogs
[39.769759]   /dev/watchdog0
[39.775148] [001/165] (960s left) i915_module_load (load)
[39.826602] Starting subtest: load
[40.904141] Subtest load: SUCCESS (1.034s)
[40.942496] [002/165] (959s left) core_auth (basic-auth)
[41.039873] Starting subtest: basic-auth
[41.043491] Subtest basic-auth: SUCCESS (0.001s)
[41.108289] [003/165] (959s left) debugfs_test (read_all_entries)
[41.163383] Starting subtest: read_all_entries
[41.427532] Subtest read_all_entries: SUCCESS (0.264s)
[41.541937] [004/165] (958s left) debugfs_test (basic-hwmon)
[41.595032] Starting subtest: basic-hwmon
[41.598447] Subtest basic-hwmon: SUCCESS (0.003s)
[41.709521] [005/165] (958s left) fbdev (eof)
[41.777746] Starting subtest: eof
[41.779603] Subtest eof: SUCCESS (0.000s)
[41.835214] [006/165] (958s left) fbdev (info)
[41.907083] Starting subtest: info
[41.909570] Subtest info: SUCCESS (0.000s)
[41.980928] [007/165] (958s left) fbdev (nullptr)
[42.059822] Starting subtest: nullptr
[42.061121] Subtest nullptr: SUCCESS (0.000s)
[42.107654] [008/165] (958s left) fbdev (read)
[42.176730] Starting subtest: read
[43.622710] Subtest read: SUCCESS (1.443s)
[43.657922] [009/165] (956s left) fbdev (write)
[43.709793] Starting subtest: write
[44.427812] Subtest write: SUCCESS (0.715s)
[44.474969] [010/165] (955s left) gem_basic (bad-close)
[44.524499] Starting subtest: bad-close
[44.527302] Subtest bad-close: SUCCESS (0.000s)
[44.590389] [011/165] (955s left) gem_basic (create-close)
[44.637440] Starting subtest: create-close
[44.640343] Subtest create-close: SUCCESS (0.000s)
[44.707171] [012/165] (955s left) gem_basic (create-fd-close)
[44.755946] Starting subtest: create-fd-close
[44.759015] Subtest create-fd-close: SUCCESS (0.000s)
[44.824107] [013/165] (955s left) gem_busy (busy@all-engines)
[44.883104] Starting subtest: busy
[44.884705] Starting dynamic subtest: all-engines
[44.942016] Dynamic subtest all-engines: SUCCESS (0.059s)
[44.943722] Subtest busy: SUCCESS (0.059s)
[45.387376] [014/165] (955s left) gem_close_race (basic-process)
[45.476215] Starting subtest: basic-process
[45.518220] Subtest basic-process: SUCCESS (0.042s)
[45.713087] [015/165] (954s left) gem_close_race (basic-threads)
[45.815700] Starting subtest: basic-threads
[47.001253] Subtest basic-threads: SUCCESS (1.185s)
[47.242498] [016/165] (953s left) gem_ctx_create (basic)
[47.313506] Starting subtest: basic
[47.314859] Subtest basic: SUCCESS (0.000s)
[47.474242] [017/165] (953s left) gem_ctx_create (basic-files)
[47.528642] Starting subtest: basic-files
[49.551670] Subtest basic-files: SUCCESS (2.023s)
[49.980950] [018/165] (950s left) gem_ctx_exec (basic)
[50.035837] Starting subtest: basic
[50.038479] Subtest basic: SUCCESS (0.005s)
[50.150839] [019/165] (950s left) gem_exec_basic (basic)
[50.257476] Starting subtest: basic
[50.258882] Starting dynamic subtest: rcs0-smem
[50.260394] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[50.266841] Starting dynamic subtest: bcs0-smem
[50.268322] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[50.273645] Starting dynamic subtest: vcs0-smem
[50.275213] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[50.280676] Starting dynamic subtest: vcs1-smem
[50.282204] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[50.287649] Starting dynamic subtest: vecs0-smem
[50.289200] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[50.294656] Starting dynamic subtest: rcs0-lmem0
[50.296183] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[50.301633] Starting dynamic subtest: bcs0-lmem0
[50.303179] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[50.308721] Starting dynamic subtest: vcs0-lmem0
[50.310289] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[50.315801] Starting dynamic subtest: vcs1-lmem0
[50.317491] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[50.322980] Starting dynamic subtest: vecs0-lmem0
[50.324582] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[50.326158] Subtest basic: SUCCESS (0.008s)
[50.444405] [020/165] (950s left) gem_exec_create (basic)
[50.514825] Starting subtest: basic
[50.516486] Starting dynamic subtest: smem
[52.610740] Dynamic subtest smem: SUCCESS (2.095s)
[52.618276] Starting dynamic subtest: lmem0
[54.733167] Dynamic subtest lmem0: SUCCESS (2.123s)
[54.734876] Subtest basic: SUCCESS (4.218s)
[54.934211] [021/165] (945s left) gem_exec_fence (basic-busy)
[55.172794] Starting subtest: basic-busy
[55.174964] Starting dynamic subtest: rcs0
[55.273537] Dynamic subtest rcs0: SUCCESS (0.103s)
[55.283147] Starting dynamic subtest: bcs0
[55.327078] Dynamic subtest bcs0: SUCCESS (0.053s)
[55.341988] Starting dynamic subtest: vcs0
[55.382750] Dynamic subtest vcs0: SUCCESS (0.054s)
[55.408073] Starting dynamic subtest: vcs1
[55.437766] Dynamic subtest vcs1: SUCCESS (0.054s)
[55.462979] Starting dynamic subtest: vecs0
[55.490958] Dynamic subtest vecs0: SUCCESS (0.053s)
[55.494063] Subtest basic-busy: SUCCESS (0.321s)
[56.092282] [022/165] (944s left) gem_exec_fence (basic-wait)
[56.307641] Starting subtest: basic-wait
[56.309015] Starting dynamic subtest: rcs0
[56.371791] Dynamic subtest rcs0: SUCCESS (0.067s)
[56.380691] Starting dynamic subtest: bcs0
[56.423961] Dynamic subtest bcs0: SUCCESS (0.052s)
[56.441750] Starting dynamic subtest: vcs0
[56.483262] Dynamic subtest vcs0: SUCCESS (0.058s)
[56.509993] Starting dynamic subtest: vcs1
[56.539670] Dynamic subtest vcs1: SUCCESS (0.055s)
[56.565863] Starting dynamic subtest: vecs0
[56.592599] Dynamic subtest vecs0: SUCCESS (0.053s)
[56.595070] Subtest basic-wait: SUCCESS (0.287s)
[57.110837] [023/165] (943s left) gem_exec_fence (basic-await)
[57.325608] Starting subtest: basic-await
[57.327176] Starting dynamic subtest: rcs0
[57.424508] Dynamic subtest rcs0: SUCCESS (0.102s)
[57.430391] Starting dynamic subtest: bcs0
[57.504723] Dynamic subtest bcs0: SUCCESS (0.080s)
[57.512213] Starting dynamic subtest: vcs0
[57.591973] Dynamic subtest vcs0: SUCCESS (0.087s)
[57.600651] Starting dynamic subtest: vcs1
[57.686629] Dynamic subtest vcs1: SUCCESS (0.094s)
[57.693643] Starting dynamic subtest: vecs0
[57.771036] Dynamic subtest vecs0: SUCCESS (0.084s)
[57.773119] Subtest basic-await: SUCCESS (0.448s)
[58.310546] [024/165] (942s left) gem_exec_fence (nb-await)
[58.537929] Starting subtest: nb-await
[58.547731] Starting dynamic subtest: rcs0
[58.620024] Dynamic subtest rcs0: SUCCESS (0.086s)
[58.627195] Starting dynamic subtest: bcs0
[58.682786] Dynamic subtest bcs0: SUCCESS (0.061s)
[58.692613] Starting dynamic subtest: vcs0
[58.746394] Dynamic subtest vcs0: SUCCESS (0.064s)
[58.760122] Starting dynamic subtest: vcs1
[58.818907] Dynamic subtest vcs1: SUCCESS (0.071s)
[58.844980] Starting dynamic subtest: vecs0
[58.906145] Dynamic subtest vecs0: SUCCESS (0.087s)
[58.908774] Subtest nb-await: SUCCESS (0.371s)
[59.486964] [025/165] (941s left) gem_exec_gttfill (basic)
[59.543782] Starting subtest: basic
[66.044851] Subtest basic: SUCCESS (6.498s)
[66.289801] [026/165] (934s left) gem_exec_parallel (engines)
[66.396864] Starting subtest: engines
[66.398431] Starting dynamic subtest: basic
[68.059582] Dynamic subtest basic: SUCCESS (1.664s)
[68.067144] Starting dynamic subtest: contexts
[72.097133] Dynamic subtest contexts: SUCCESS (4.034s)
[72.103663] Starting dynamic subtest: fds
[76.822498] Dynamic subtest fds: SUCCESS (4.725s)
[76.828960] Starting dynamic subtest: userptr
[78.254164] Dynamic subtest userptr: SUCCESS (1.435s)
[78.255833] Subtest engines: SUCCESS (11.859s)
[78.534283] [027/165] (922s left) gem_exec_store (basic)
[78.617750] Starting subtest: basic
[78.720523] Subtest basic: SUCCESS (0.102s)
[78.951506] [028/165] (921s left) gem_flink_basic (bad-flink)
[79.002595] Starting subtest: bad-flink
[79.004502] Subtest bad-flink: SUCCESS (0.000s)
[79.055987] [029/165] (921s left) gem_flink_basic (bad-open)
[79.115537] Starting subtest: bad-open
[79.117349] Subtest bad-open: SUCCESS (0.000s)
[79.174859] [030/165] (921s left) gem_flink_basic (basic)
[79.227198] Starting subtest: basic
[79.229180] Subtest basic: SUCCESS (0.000s)
[79.296387] [031/165] (921s left) gem_flink_basic (double-flink)
[79.374325] Starting subtest: double-flink
[79.375734] Subtest double-flink: SUCCESS (0.000s)
[79.463124] [032/165] (921s left) gem_flink_basic (flink-lifetime)
[79.515884] Starting subtest: flink-lifetime
[79.517286] Subtest flink-lifetime: SUCCESS (0.002s)
[79.605244] [033/165] (921s left) gem_huc_copy (huc-copy)
[79.666905] Starting subtest: huc-copy
[79.671273] Subtest huc-copy: SUCCESS (0.004s)
[79.801369] [034/165] (921s left) gem_linear_blits (basic)
[79.939133] Starting subtest: basic
[79.963208] Subtest basic: SUCCESS (0.024s)
[80.126838] [035/165] (920s left) gem_mmap (basic)
[80.242048] Subtest basic: SKIP (0.000s)
[80.286315] [036/165] (920s left) gem_mmap_gtt (basic)
[80.353860] Subtest basic: SKIP (0.000s)
[80.380783] [037/165] (920s left) gem_render_linear_blits (basic)
[80.431721] Starting subtest: basic
[80.493310] Subtest basic: SUCCESS (0.062s)
[80.566773] [038/165] (920s left) gem_render_tiled_blits (basic)
[80.622067] Subtest basic: SKIP (0.000s)
[80.647290] [039/165] (920s left) gem_ringfill (basic-all)
[81.076548] Starting subtest: basic-all
[82.366259] Subtest basic-all: SUCCESS (1.297s)
[82.491912] [040/165] (918s left) gem_softpin (allocator-basic)
[82.576272] Starting subtest: allocator-basic
[82.785714] Subtest allocator-basic: SUCCESS (0.206s)
[82.875236] [041/165] (918s left) gem_softpin (allocator-basic-reserve)
[82.928291] Starting subtest: allocator-basic-reserve
[83.143148] Subtest allocator-basic-reserve: SUCCESS (0.211s)
[83.273061] [042/165] (917s left) gem_softpin (safe-alignment)
[83.340340] Starting subtest: safe-alignment
[83.372482] Subtest safe-alignment: SUCCESS (0.032s)
[83.502542] [043/165] (917s left) gem_sync (basic-all)
[83.562374] Starting subtest: basic-all
[85.921311] Subtest basic-all: SUCCESS (2.362s)
[86.145967] [044/165] (915s left) gem_sync (basic-each)
[86.211743] Starting subtest: basic-each
[88.290456] Subtest basic-each: SUCCESS (2.086s)
[88.525469] [045/165] (912s left) gem_tiled_blits (basic)
[88.618009] Subtest basic: SKIP (0.000s)
[88.646310] [046/165] (912s left) gem_tiled_fence_blits (basic)
[88.699425] Subtest basic: SKIP (0.000s)
[88.729296] [047/165] (912s left) gem_tiled_pread_basic
[88.796300] [048/165] (912s left) gem_wait (busy@all-engines)
[88.855702] Starting subtest: busy
[88.857318] Starting dynamic subtest: all-engines
[89.418111] Dynamic subtest all-engines: SUCCESS (0.562s)
[89.419741] Subtest busy: SUCCESS (0.562s)
[89.668961] [049/165] (911s left) gem_wait (wait@all-engines)
[89.730932] Starting subtest: wait
[89.732435] Starting dynamic subtest: all-engines
[90.818544] Dynamic subtest all-engines: SUCCESS (1.086s)
[90.820298] Subtest wait: SUCCESS (1.086s)
[91.083990] [050/165] (910s left) i915_getparams_basic (basic-eu-total)
[91.162397] Starting subtest: basic-eu-total
[91.165811] Subtest basic-eu-total: SUCCESS (0.000s)
[91.221277] [051/165] (910s left) i915_getparams_basic (basic-subslice-total)
[91.279426] Starting subtest: basic-subslice-total
[91.282772] Subtest basic-subslice-total: SUCCESS (0.000s)
[91.338876] [052/165] (910s left) i915_hangman (error-state-basic)
[91.403111] Starting subtest: error-state-basic
[91.518561] Subtest error-state-basic: SUCCESS (0.117s)
[91.607944] [053/165] (909s left) i915_pciid
[91.725192] [054/165] (909s left) kms_addfb_basic (addfb25-4-tiled)
[91.865784] Starting subtest: addfb25-4-tiled
[91.867346] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[91.939238] [055/165] (909s left) kms_addfb_basic (addfb25-bad-modifier)
[92.005829] Starting subtest: addfb25-bad-modifier
[92.007389] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[92.138793] [056/165] (909s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[92.194977] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[92.322524] [057/165] (909s left) kms_addfb_basic (addfb25-modifier-no-flag)
[92.372972] Starting subtest: addfb25-modifier-no-flag
[92.374658] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[92.508555] [058/165] (909s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[92.583026] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[92.703266] [059/165] (908s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[92.752880] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[92.871933] [060/165] (908s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[92.973694] Starting subtest: addfb25-yf-tiled-legacy
[92.975165] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[93.057191] [061/165] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[93.178271] Starting subtest: addfb25-y-tiled-legacy
[93.179960] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[93.256025] [062/165] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[93.356832] Starting subtest: addfb25-y-tiled-small-legacy
[93.358634] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[93.442027] [063/165] (908s left) kms_addfb_basic (bad-pitch-0)
[93.497416] Starting subtest: bad-pitch-0
[93.499260] Subtest bad-pitch-0: SUCCESS (0.000s)
[93.623782] [064/165] (908s left) kms_addfb_basic (bad-pitch-1024)
[93.677140] Starting subtest: bad-pitch-1024
[93.678982] Subtest bad-pitch-1024: SUCCESS (0.000s)
[93.786667] [065/165] (907s left) kms_addfb_basic (bad-pitch-128)
[93.833429] Starting subtest: bad-pitch-128
[93.834969] Subtest bad-pitch-128: SUCCESS (0.000s)
[93.977322] [066/165] (907s left) kms_addfb_basic (bad-pitch-256)
[94.055923] Starting subtest: bad-pitch-256
[94.057614] Subtest bad-pitch-256: SUCCESS (0.000s)
[94.192335] [067/165] (907s left) kms_addfb_basic (bad-pitch-32)
[94.245724] Starting subtest: bad-pitch-32
[94.247418] Subtest bad-pitch-32: SUCCESS (0.000s)
[94.374938] [068/165] (907s left) kms_addfb_basic (bad-pitch-63)
[94.428657] Starting subtest: bad-pitch-63
[94.430557] Subtest bad-pitch-63: SUCCESS (0.000s)
[94.558348] [069/165] (907s left) kms_addfb_basic (bad-pitch-65536)
[94.612543] Starting subtest: bad-pitch-65536
[94.614314] Subtest bad-pitch-65536: SUCCESS (0.000s)
[94.719735] [070/165] (907s left) kms_addfb_basic (bad-pitch-999)
[94.774354] Starting subtest: bad-pitch-999
[94.775903] Subtest bad-pitch-999: SUCCESS (0.000s)
[94.906243] [071/165] (906s left) kms_addfb_basic (basic)
[94.954900] Starting subtest: basic
[94.956357] Subtest basic: SUCCESS (0.000s)
[95.088552] [072/165] (906s left) kms_addfb_basic (basic-x-tiled-legacy)
[95.158363] Starting subtest: basic-x-tiled-legacy
[95.161226] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[95.291479] [073/165] (906s left) kms_addfb_basic (basic-y-tiled-legacy)
[95.366995] Starting subtest: basic-y-tiled-legacy
[95.370290] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[95.487761] [074/165] (906s left) kms_addfb_basic (bo-too-small)
[95.644207] Starting subtest: bo-too-small
[95.646054] Subtest bo-too-small: SUCCESS (0.000s)
[95.722422] [075/165] (906s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[95.823893] Starting subtest: bo-too-small-due-to-tiling
[95.827050] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[95.905375] [076/165] (906s left) kms_addfb_basic (clobberred-modifier)
[95.960870] Starting subtest: clobberred-modifier
[95.963986] Subtest clobberred-modifier: SKIP (0.000s)
[96.089490] [077/165] (905s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[96.161307] Starting subtest: framebuffer-vs-set-tiling
[96.164880] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[96.288286] [078/165] (905s left) kms_addfb_basic (invalid-get-prop)
[96.338488] Starting subtest: invalid-get-prop
[96.340098] Subtest invalid-get-prop: SUCCESS (0.000s)
[96.474655] [079/165] (905s left) kms_addfb_basic (invalid-get-prop-any)
[96.529740] Starting subtest: invalid-get-prop-any
[96.531412] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[96.654285] [080/165] (905s left) kms_addfb_basic (invalid-set-prop)
[96.716790] Starting subtest: invalid-set-prop
[96.718200] Subtest invalid-set-prop: SUCCESS (0.000s)
[96.836264] [081/165] (905s left) kms_addfb_basic (invalid-set-prop-any)
[96.890972] Starting subtest: invalid-set-prop-any
[96.892480] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[97.022309] [082/165] (905s left) kms_addfb_basic (no-handle)
[97.084990] Starting subtest: no-handle
[97.086531] Subtest no-handle: SUCCESS (0.000s)
[97.224653] [083/165] (904s left) kms_addfb_basic (size-max)
[97.343757] Starting subtest: size-max
[97.345531] Subtest size-max: SUCCESS (0.000s)
[97.421575] [084/165] (904s left) kms_addfb_basic (small-bo)
[97.519996] Starting subtest: small-bo
[97.521839] Subtest small-bo: SUCCESS (0.000s)
[97.607061] [085/165] (904s left) kms_addfb_basic (tile-pitch-mismatch)
[97.661853] Starting subtest: tile-pitch-mismatch
[97.665181] Subtest tile-pitch-mismatch: SKIP (0.000s)
[97.790716] [086/165] (904s left) kms_addfb_basic (too-high)
[97.892810] Starting subtest: too-high
[97.894233] Subtest too-high: SUCCESS (0.000s)
[97.972086] [087/165] (904s left) kms_addfb_basic (too-wide)
[98.073774] Starting subtest: too-wide
[98.075310] Subtest too-wide: SUCCESS (0.000s)
[98.155677] [088/165] (903s left) kms_addfb_basic (unused-handle)
[98.207321] Starting subtest: unused-handle
[98.208762] Subtest unused-handle: SUCCESS (0.000s)
[98.338153] [089/165] (903s left) kms_addfb_basic (unused-modifier)
[98.388848] Starting subtest: unused-modifier
[98.390360] Subtest unused-modifier: SUCCESS (0.000s)
[98.503729] [090/165] (903s left) kms_addfb_basic (unused-offsets)
[98.562926] Starting subtest: unused-offsets
[98.564487] Subtest unused-offsets: SUCCESS (0.000s)
[98.689113] [091/165] (903s left) kms_addfb_basic (unused-pitches)
[98.738802] Starting subtest: unused-pitches
[98.740694] Subtest unused-pitches: SUCCESS (0.000s)
[98.875913] [092/165] (903s left) kms_busy (basic)
[99.024351] Starting subtest: basic
[99.025824] Starting dynamic subtest: flip
[99.881716] Dynamic subtest flip: SUCCESS (0.855s)
[99.889137] Starting dynamic subtest: modeset
[100.715410] Dynamic subtest modeset: SUCCESS (0.835s)
[100.717037] Subtest basic: SUCCESS (1.691s)
[100.861840] [093/165] (901s left) kms_prop_blob (basic)
[100.912609] Starting subtest: basic
[100.914436] Subtest basic: SUCCESS (0.000s)
[100.997941] [094/165] (901s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[101.105605] Starting subtest: basic-busy-flip-before-cursor-atomic
[101.108378] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[101.160110] [095/165] (901s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[101.256335] Starting subtest: basic-busy-flip-before-cursor-legacy
[101.259269] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[101.311353] [096/165] (901s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[101.407738] Starting subtest: basic-flip-after-cursor-atomic
[102.401433] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.993s)
[102.547366] [097/165] (899s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[102.651159] Starting subtest: basic-flip-after-cursor-legacy
[103.667325] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.016s)
[103.806658] [098/165] (898s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[103.904688] Starting subtest: basic-flip-after-cursor-varying-size
[104.927913] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.022s)
[105.075719] [099/165] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[105.175432] Starting subtest: basic-flip-before-cursor-atomic
[106.178081] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.004s)
[106.311814] [100/165] (896s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[106.412191] Starting subtest: basic-flip-before-cursor-legacy
[107.432948] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.022s)
[107.574193] [101/165] (894s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[107.681751] Starting subtest: basic-flip-before-cursor-varying-size
[108.690132] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.010s)
[108.837167] [102/165] (893s left) kms_dsc (dsc-basic)
[108.936696] Subtest dsc-basic: SKIP (0.000s)
[108.963762] [103/165] (893s left) kms_flip (basic-flip-vs-dpms)
[109.063421] Starting subtest: basic-flip-vs-dpms
[109.069997] Starting dynamic subtest: A-HDMI-A2
[109.902503] Dynamic subtest A-HDMI-A2: SUCCESS (0.832s)
[109.910129] Starting dynamic subtest: B-HDMI-A2
[110.641547] Dynamic subtest B-HDMI-A2: SUCCESS (0.735s)
[110.652656] Starting dynamic subtest: C-HDMI-A2
[111.360772] Dynamic subtest C-HDMI-A2: SUCCESS (0.720s)
[111.368330] Starting dynamic subtest: D-HDMI-A2
[112.097262] Dynamic subtest D-HDMI-A2: SUCCESS (0.735s)
[112.101283] Subtest basic-flip-vs-dpms: SUCCESS (3.038s)
[112.262858] [104/165] (890s left) kms_flip (basic-flip-vs-modeset)
[112.363271] Starting subtest: basic-flip-vs-modeset
[112.370752] Starting dynamic subtest: A-HDMI-A2
[113.135723] Dynamic subtest A-HDMI-A2: SUCCESS (0.764s)
[113.143104] Starting dynamic subtest: B-HDMI-A2
[113.896154] Dynamic subtest B-HDMI-A2: SUCCESS (0.759s)
[113.903644] Starting dynamic subtest: C-HDMI-A2
[114.611423] Dynamic subtest C-HDMI-A2: SUCCESS (0.714s)
[114.618848] Starting dynamic subtest: D-HDMI-A2
[115.329026] Dynamic subtest D-HDMI-A2: SUCCESS (0.717s)
[115.332537] Subtest basic-flip-vs-modeset: SUCCESS (2.969s)
[115.486016] [105/165] (886s left) kms_flip (basic-flip-vs-wf_vblank)
[115.592814] Starting subtest: basic-flip-vs-wf_vblank
[115.599889] Starting dynamic subtest: A-HDMI-A2
[116.661715] Dynamic subtest A-HDMI-A2: SUCCESS (1.062s)
[116.671094] Starting dynamic subtest: B-HDMI-A2
[117.652467] Dynamic subtest B-HDMI-A2: SUCCESS (0.989s)
[117.661884] Starting dynamic subtest: C-HDMI-A2
[118.644195] Dynamic subtest C-HDMI-A2: SUCCESS (0.990s)
[118.652209] Starting dynamic subtest: D-HDMI-A2
[119.635373] Dynamic subtest D-HDMI-A2: SUCCESS (0.990s)
[119.639836] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.048s)
[119.845935] [106/165] (882s left) kms_flip (basic-plain-flip)
[119.946244] Starting subtest: basic-plain-flip
[119.953327] Starting dynamic subtest: A-HDMI-A2
[120.764257] Dynamic subtest A-HDMI-A2: SUCCESS (0.811s)
[120.774393] Starting dynamic subtest: B-HDMI-A2
[121.471711] Dynamic subtest B-HDMI-A2: SUCCESS (0.706s)
[121.479951] Starting dynamic subtest: C-HDMI-A2
[122.179855] Dynamic subtest C-HDMI-A2: SUCCESS (0.707s)
[122.188032] Starting dynamic subtest: D-HDMI-A2
[122.887919] Dynamic subtest D-HDMI-A2: SUCCESS (0.707s)
[122.892048] Subtest basic-plain-flip: SUCCESS (2.947s)
[123.100198] [107/165] (879s left) kms_force_connector_basic (force-connector-state)
[123.257345] Starting subtest: force-connector-state
[123.474588] Subtest force-connector-state: SUCCESS (0.219s)
[123.729905] [108/165] (878s left) kms_force_connector_basic (force-edid)
[123.846353] Starting subtest: force-edid
[123.861410] Subtest force-edid: SUCCESS (0.016s)
[124.059970] [109/165] (878s left) kms_force_connector_basic (force-load-detect)
[124.165992] Starting subtest: force-load-detect
[124.168834] Subtest force-load-detect: SKIP (0.000s)
[124.343629] [110/165] (878s left) kms_force_connector_basic (prune-stale-modes)
[124.449157] Starting subtest: prune-stale-modes
[124.461143] Subtest prune-stale-modes: SUCCESS (0.012s)
[124.661599] [111/165] (877s left) kms_frontbuffer_tracking (basic)
[124.768046] Starting subtest: basic
[127.410087] Subtest basic: SUCCESS (2.643s)
[127.546618] [112/165] (875s left) kms_hdmi_inject (inject-audio)
[127.681219] Starting subtest: inject-audio
[127.775171] Subtest inject-audio: SUCCESS (0.092s)
[127.977539] [113/165] (874s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[128.100040] Starting subtest: compare-crc-sanitycheck-xr24
[128.101427] Starting dynamic subtest: pipe-A-HDMI-A-2
[128.615368] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.514s)
[128.626335] Starting dynamic subtest: pipe-B-HDMI-A-2
[129.035207] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.415s)
[129.042640] Starting dynamic subtest: pipe-C-HDMI-A-2
[129.476864] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.439s)
[129.484552] Starting dynamic subtest: pipe-D-HDMI-A-2
[129.931428] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.452s)
[129.932945] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.832s)
[130.062848] [114/165] (872s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[130.168251] Starting subtest: compare-crc-sanitycheck-nv12
[130.169979] Starting dynamic subtest: pipe-A-HDMI-A-2
[130.800804] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.629s)
[130.808388] Starting dynamic subtest: pipe-B-HDMI-A-2
[131.304753] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.503s)
[131.313916] Starting dynamic subtest: pipe-C-HDMI-A-2
[131.808135] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.501s)
[131.817595] Starting dynamic subtest: pipe-D-HDMI-A-2
[132.338178] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.526s)
[132.339894] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.169s)
[132.471834] [115/165] (870s left) kms_pipe_crc_basic (hang-read-crc)
[132.614128] Starting subtest: hang-read-crc
[132.615753] Starting dynamic subtest: pipe-A-HDMI-A-2
[133.957342] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.341s)
[133.965205] Starting dynamic subtest: pipe-B-HDMI-A-2
[135.189177] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.229s)
[135.198887] Starting dynamic subtest: pipe-C-HDMI-A-2
[136.432151] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.240s)
[136.441969] Starting dynamic subtest: pipe-D-HDMI-A-2
[137.665977] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (1.230s)
[137.667884] Subtest hang-read-crc: SUCCESS (5.053s)
[137.832511] [116/165] (864s left) kms_pipe_crc_basic (nonblocking-crc)
[137.934615] Starting subtest: nonblocking-crc
[137.936088] Starting dynamic subtest: pipe-A-HDMI-A-2
[138.652636] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.717s)
[138.660347] Starting dynamic subtest: pipe-B-HDMI-A-2
[139.280697] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.626s)
[139.299594] Starting dynamic subtest: pipe-C-HDMI-A-2
[139.916981] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.628s)
[139.924657] Starting dynamic subtest: pipe-D-HDMI-A-2
[140.501116] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.581s)
[140.502847] Subtest nonblocking-crc: SUCCESS (2.567s)
[140.637232] [117/165] (862s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[140.739405] Starting subtest: nonblocking-crc-frame-sequence
[140.740872] Starting dynamic subtest: pipe-A-HDMI-A-2
[141.459104] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.718s)
[141.468772] Starting dynamic subtest: pipe-B-HDMI-A-2
[142.077923] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.615s)
[142.085566] Starting dynamic subtest: pipe-C-HDMI-A-2
[142.638263] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.559s)
[142.648240] Starting dynamic subtest: pipe-D-HDMI-A-2
[143.207460] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.566s)
[143.209009] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.469s)
[143.354330] [118/165] (859s left) kms_pipe_crc_basic (read-crc)
[143.459385] Starting subtest: read-crc
[143.463894] Starting dynamic subtest: pipe-A-HDMI-A-2
[144.106681] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.644s)
[144.114214] Starting dynamic subtest: pipe-B-HDMI-A-2
[144.658124] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.549s)
[144.667702] Starting dynamic subtest: pipe-C-HDMI-A-2
[145.186807] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.525s)
[145.194244] Starting dynamic subtest: pipe-D-HDMI-A-2
[145.718566] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.531s)
[145.719891] Subtest read-crc: SUCCESS (2.260s)
[145.856270] [119/165] (856s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[145.956011] Starting subtest: read-crc-frame-sequence
[145.960186] Starting dynamic subtest: pipe-A-HDMI-A-2
[146.609262] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.650s)
[146.617126] Starting dynamic subtest: pipe-B-HDMI-A-2
[147.125735] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.515s)
[147.135142] Starting dynamic subtest: pipe-C-HDMI-A-2
[147.657036] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.528s)
[147.666725] Starting dynamic subtest: pipe-D-HDMI-A-2
[148.226221] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (0.566s)
[148.227758] Subtest read-crc-frame-sequence: SUCCESS (2.270s)
[148.374146] [120/165] (854s left) kms_pm_backlight (basic-brightness)
[148.491208] Subtest basic-brightness: SKIP (0.000s)
[148.514780] [121/165] (854s left) kms_pm_rpm (basic-pci-d3-state)
[150.484567] Starting subtest: basic-pci-d3-state
[150.779896] Subtest basic-pci-d3-state: SUCCESS (0.296s)
[151.073051] [122/165] (851s left) kms_pm_rpm (basic-rte)
[151.122446] Starting subtest: basic-rte
[152.804825] Subtest basic-rte: SUCCESS (1.684s)
[153.582247] [123/165] (849s left) kms_psr (psr_primary_page_flip)
[153.725487] [124/165] (849s left) kms_psr (psr_cursor_plane_move)
[153.857999] [125/165] (849s left) kms_psr (psr_sprite_plane_onoff)
[153.990422] [126/165] (848s left) kms_psr (psr_primary_mmap_gtt)
[154.157170] [127/165] (848s left) kms_setmode (basic-clone-single-crtc)
[154.208993] Starting subtest: basic-clone-single-crtc
[154.213992] Subtest basic-clone-single-crtc: SKIP (0.001s)
[154.271404] [128/165] (848s left) i915_pm_rps (basic-api)
[154.345641] Starting subtest: basic-api
[154.348788] Subtest basic-api: SKIP (0.000s)
[154.429871] [129/165] (848s left) prime_self_import (basic-llseek-bad)
[154.508573] Starting subtest: basic-llseek-bad
[154.516226] Subtest basic-llseek-bad: SUCCESS (0.005s)
[154.583291] [130/165] (848s left) prime_self_import (basic-llseek-size)
[154.626935] Starting subtest: basic-llseek-size
[154.631889] Subtest basic-llseek-size: SUCCESS (0.003s)
[154.756521] [131/165] (848s left) prime_self_import (basic-with_fd_dup)
[154.813987] Starting subtest: basic-with_fd_dup
[154.816592] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[154.908157] [132/165] (848s left) prime_self_import (basic-with_one_bo)
[154.978438] Starting subtest: basic-with_one_bo
[154.981337] Subtest basic-with_one_bo: SUCCESS (0.003s)
[155.044471] [133/165] (848s left) prime_self_import (basic-with_one_bo_two_files)
[155.098390] Starting subtest: basic-with_one_bo_two_files
[155.105165] Subtest basic-with_one_bo_two_files: SUCCESS (0.007s)
[155.209084] [134/165] (847s left) prime_self_import (basic-with_two_bos)
[155.284040] Starting subtest: basic-with_two_bos
[155.287014] Subtest basic-with_two_bos: SUCCESS (0.003s)
[155.372743] [135/165] (847s left) prime_vgem (basic-fence-flip)
[155.453869] Starting subtest: basic-fence-flip
[155.516283] Subtest basic-fence-flip: SKIP (0.061s)
[155.608361] [136/165] (847s left) prime_vgem (basic-fence-mmap)
[155.702196] Starting subtest: basic-fence-mmap
[155.706437] Subtest basic-fence-mmap: SKIP (0.000s)
[155.848054] [137/165] (847s left) prime_vgem (basic-fence-read)
[155.936698] Starting subtest: basic-fence-read
[155.943374] Subtest basic-fence-read: SKIP (0.005s)
[156.061631] [138/165] (847s left) prime_vgem (basic-gtt)
[156.159649] Starting subtest: basic-gtt
[156.162779] Subtest basic-gtt: SKIP (0.000s)
[156.266172] [139/165] (847s left) prime_vgem (basic-read)
[156.319700] Starting subtest: basic-read
[156.326787] Subtest basic-read: SKIP (0.005s)
[156.429707] [140/165] (846s left) prime_vgem (basic-write)
[156.502156] Starting subtest: basic-write
[156.508744] Subtest basic-write: SKIP (0.005s)
[156.617671] [141/165] (846s left) vgem_basic (setversion)
[156.714831] Starting subtest: setversion
[156.718391] Subtest setversion: SUCCESS (0.000s)
[156.765819] [142/165] (846s left) vgem_basic (create)
[156.831618] Starting subtest: create
[156.833479] Subtest create: SUCCESS (0.000s)
[156.887312] [143/165] (846s left) vgem_basic (debugfs)
[156.948386] Starting subtest: debugfs
[156.950216] Subtest debugfs: SUCCESS (0.000s)
[157.001521] [144/165] (846s left) vgem_basic (dmabuf-export)
[157.064987] Starting subtest: dmabuf-export
[157.068470] Subtest dmabuf-export: SUCCESS (0.003s)
[157.203147] [145/165] (846s left) vgem_basic (dmabuf-fence)
[157.297872] Starting subtest: dmabuf-fence
[157.299514] Subtest dmabuf-fence: SUCCESS (0.000s)
[157.349848] [146/165] (846s left) vgem_basic (dmabuf-fence-before)
[157.418619] Starting subtest: dmabuf-fence-before
[157.421612] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[157.484938] [147/165] (846s left) vgem_basic (dmabuf-mmap)
[157.549072] Starting subtest: dmabuf-mmap
[157.576849] Subtest dmabuf-mmap: SUCCESS (0.028s)
[157.638506] [148/165] (845s left) vgem_basic (mmap)
[157.714511] Starting subtest: mmap
[157.720862] Subtest mmap: SUCCESS (0.007s)
[157.764087] [149/165] (845s left) vgem_basic (second-client)
[157.816298] Starting subtest: second-client
[157.848587] Subtest second-client: SUCCESS (0.033s)
[157.927037] [150/165] (845s left) vgem_basic (sysfs)
[157.999412] Starting subtest: sysfs
[158.001774] Subtest sysfs: SUCCESS (0.002s)
[158.072902] [151/165] (845s left) core_hotunplug (unbind-rebind)
[158.197228] Starting subtest: unbind-rebind
[161.609718] Subtest unbind-rebind: SUCCESS (3.413s)
[161.629249] [152/165] (841s left) vgem_basic (unload)
[161.680164] Starting subtest: unload
[190.640058] Subtest unload: SUCCESS (28.957s)
[190.742404] [153/165] (812s left) i915_module_load (reload)
[190.791261] Starting subtest: reload
[192.908785] Subtest reload: SUCCESS (2.119s)
[192.932013] [154/165] (810s left) gem_lmem_swapping (basic)
[194.535194] Starting subtest: basic
[194.536834] Starting dynamic subtest: lmem0
[214.971189] Dynamic subtest lmem0: SUCCESS (20.434s)
[214.972471] Subtest basic: SUCCESS (20.436s)
[216.582123] [155/165] (787s left) gem_lmem_swapping (parallel-random-engines)
[217.146564] Starting subtest: parallel-random-engines
[217.148734] Starting dynamic subtest: lmem0
[251.598355] Dynamic subtest lmem0: SUCCESS (34.447s)
[251.600293] Subtest parallel-random-engines: SUCCESS (34.449s)
[252.798441] [156/165] (750s left) gem_lmem_swapping (random-engines)
[253.383130] Starting subtest: random-engines
[253.384478] Starting dynamic subtest: lmem0
[254.330467] Dynamic subtest lmem0: SUCCESS (0.944s)
[254.331769] Subtest random-engines: SUCCESS (0.945s)
[255.418018] [157/165] (748s left) gem_lmem_swapping (verify-random)
[255.988637] Starting subtest: verify-random
[255.990225] Starting dynamic subtest: lmem0
[264.947259] Dynamic subtest lmem0: SUCCESS (8.962s)
[264.948724] Subtest verify-random: SUCCESS (8.963s)
[266.150828] [158/165] (737s left) i915_pm_rpm (module-reload)
[268.807870] Starting subtest: module-reload
[276.899717] Subtest module-reload: SUCCESS (8.090s)
[276.915826] [159/165] (726s left) i915_selftest (live)
[276.970754] Starting subtest: live
[276.972289] Starting dynamic subtest: sanitycheck
[277.822566] Dynamic subtest sanitycheck: SUCCESS (0.848s)
[277.829803] Starting dynamic subtest: uncore
[278.680489] Dynamic subtest uncore: SUCCESS (0.857s)
[278.687991] Starting dynamic subtest: workarounds
[281.087346] Dynamic subtest workarounds: SUCCESS (2.406s)
[281.094603] Starting dynamic subtest: gt_engines
[282.483479] Dynamic subtest gt_engines: SUCCESS (1.395s)
[282.490358] Starting dynamic subtest: gt_timelines
[329.839554] Dynamic subtest gt_timelines: SUCCESS (47.355s)
[329.848260] Starting dynamic subtest: gt_contexts
[330.745860] Dynamic subtest gt_contexts: SUCCESS (0.904s)
[330.753792] Starting dynamic subtest: gt_lrc
[336.462377] Dynamic subtest gt_lrc: SUCCESS (5.715s)
[336.469385] Starting dynamic subtest: gt_mocs
[338.079458] Dynamic subtest gt_mocs: SUCCESS (1.616s)
[338.087013] Starting dynamic subtest: gt_pm
[339.842511] Dynamic subtest gt_pm: SUCCESS (1.762s)
[339.850351] Starting dynamic subtest: gt_heartbeat
[340.879630] Dynamic subtest gt_heartbeat: SUCCESS (1.035s)
[340.887324] Starting dynamic subtest: gt_tlb
[351.102624] Dynamic subtest gt_tlb: SUCCESS (10.222s)
[351.108852] Starting dynamic subtest: requests
[360.898721] Dynamic subtest requests: SUCCESS (9.795s)
[360.906102] Starting dynamic subtest: migrate
[364.850192] Dynamic subtest migrate: SUCCESS (3.950s)
[364.856923] Starting dynamic subtest: active
[365.719568] Dynamic subtest active: SUCCESS (0.868s)
[365.727148] Starting dynamic subtest: objects
[367.911458] Dynamic subtest objects: SUCCESS (2.190s)
[367.928511] Starting dynamic subtest: mman
[371.275410] Dynamic subtest mman: SUCCESS (3.363s)
[371.282289] Starting dynamic subtest: dmabuf
[372.277463] Dynamic subtest dmabuf: SUCCESS (1.001s)
[372.284985] Starting dynamic subtest: vma
[373.118413] Dynamic subtest vma: SUCCESS (0.839s)
[373.125793] Starting dynamic subtest: coherency
[382.189089] Dynamic subtest coherency: SUCCESS (9.070s)
[382.195417] Starting dynamic subtest: gtt
[391.712577] Dynamic subtest gtt: SUCCESS (9.522s)
[391.719979] Starting dynamic subtest: gem
[392.661861] Dynamic subtest gem: SUCCESS (0.940s)
[392.669870] Starting dynamic subtest: evict
[404.693383] Dynamic subtest evict: SUCCESS (12.039s)
[404.700635] Starting dynamic subtest: hugepages
[421.422222] Dynamic subtest hugepages: SUCCESS (16.728s)
[421.429041] Starting dynamic subtest: gem_contexts
[447.486361] Dynamic subtest gem_contexts: SUCCESS (26.063s)
[447.492740] Starting dynamic subtest: client
[448.416655] Dynamic subtest client: SUCCESS (0.929s)
[448.423960] Starting dynamic subtest: gem_migrate
[450.476297] Dynamic subtest gem_migrate: SUCCESS (2.058s)
[450.483235] Starting dynamic subtest: reset
[451.377480] Dynamic subtest reset: SUCCESS (0.900s)
[451.384807] Starting dynamic subtest: memory_region
[453.820330] Dynamic subtest memory_region: SUCCESS (2.442s)
[453.827830] Starting dynamic subtest: hangcheck
[482.145930] Dynamic subtest hangcheck: SUCCESS (28.324s)
[482.153288] Starting dynamic subtest: execlists
[482.973302] Dynamic subtest execlists: SUCCESS (0.827s)
[482.980213] Starting dynamic subtest: ring_submission
[483.796417] Dynamic subtest ring_submission: SUCCESS (0.822s)
[483.803039] Starting dynamic subtest: perf
[484.797333] Dynamic subtest perf: SUCCESS (1.000s)
[484.804479] Starting dynamic subtest: slpc
[490.089618] Dynamic subtest slpc: SUCCESS (5.291s)
[490.097114] Starting dynamic subtest: guc
[493.031468] Dynamic subtest guc: SUCCESS (2.941s)
[493.039457] Starting dynamic subtest: guc_multi_lrc
[493.902487] Dynamic subtest guc_multi_lrc: SUCCESS (0.870s)
[493.909405] Starting dynamic subtest: guc_hang
[495.440381] Dynamic subtest guc_hang: SUCCESS (1.537s)
[495.448029] Starting dynamic subtest: late_gt_pm
[496.345356] Dynamic subtest late_gt_pm: SUCCESS (0.903s)
[496.347034] Subtest live: SUCCESS (219.372s)
[496.454284] [160/165] (507s left) dmabuf (all-tests)
[496.518165] Starting subtest: all-tests
[496.521580] Starting dynamic subtest: sanitycheck
[496.670516] Dynamic subtest sanitycheck: SUCCESS (0.150s)
[496.705239] Starting dynamic subtest: dma_fence
[496.859111] Dynamic subtest dma_fence: SUCCESS (0.184s)
[496.869627] Starting dynamic subtest: dma_fence_chain
[509.667027] Dynamic subtest dma_fence_chain: SUCCESS (12.803s)
[509.673473] Starting dynamic subtest: dma_fence_unwrap
[509.750162] Dynamic subtest dma_fence_unwrap: SUCCESS (0.074s)
[509.761039] Starting dynamic subtest: dma_resv
[509.829945] Dynamic subtest dma_resv: SUCCESS (0.084s)
[509.832940] Subtest all-tests: SUCCESS (13.315s)
[509.883870] [161/165] (493s left) i915_suspend (basic-s2idle-without-i915)
[509.961420] Starting subtest: basic-s2idle-without-i915
[528.065205] Subtest basic-s2idle-without-i915: SUCCESS (3.271s)
[528.145933] [162/165] (490s left) i915_suspend (basic-s3-without-i915)
[528.201601] Starting subtest: basic-s3-without-i915
[550.176499] Subtest basic-s3-without-i915: SUCCESS (10.071s)
[550.252710] [163/165] (480s left) gem_exec_suspend (basic-s0)
[550.316559] Starting subtest: basic-S0
[550.318257] Starting dynamic subtest: smem
[570.722663] Dynamic subtest smem: SUCCESS (4.538s)
[570.731437] Starting dynamic subtest: lmem0
[589.689807] Dynamic subtest lmem0: SUCCESS (4.380s)
[589.691380] Subtest basic-S0: SUCCESS (8.920s)
[589.871001] [164/165] (471s left) gem_exec_suspend (basic-s3)
[589.927283] Starting subtest: basic-S3
[589.928677] Starting dynamic subtest: smem
[613.815982] Dynamic subtest smem: SUCCESS (12.021s)
[613.825256] Starting dynamic subtest: lmem0
[637.768455] Dynamic subtest lmem0: SUCCESS (11.800s)
[637.770176] Subtest basic-S3: SUCCESS (23.823s)
[637.977161] [165/165] (447s left) kms_pipe_crc_basic (suspend-read-crc)
[638.109149] Starting subtest: suspend-read-crc
[638.113666] Starting dynamic subtest: pipe-A-HDMI-A-2
[660.308449] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (9.992s)
[660.318416] Starting dynamic subtest: pipe-B-HDMI-A-2
[682.296922] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (9.736s)
[682.307442] Starting dynamic subtest: pipe-C-HDMI-A-2
[704.250333] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (9.654s)
[704.260925] Starting dynamic subtest: pipe-D-HDMI-A-2
[726.319947] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (9.722s)
[726.321336] Subtest suspend-read-crc: SUCCESS (39.115s)
[726.431703] Closing watchdogs
Done.