[39.397123] Initializing watchdogs
[39.397337]   /dev/watchdog0
[39.407813] [001/171] (960s left) i915_module_load (load)
[39.480984] Starting subtest: load
[40.312598] Subtest load: SUCCESS (0.832s)
[40.331334] [002/171] (959s left) core_auth (basic-auth)
[40.448732] Starting subtest: basic-auth
[40.450406] Subtest basic-auth: SUCCESS (0.001s)
[40.486261] [003/171] (959s left) debugfs_test (read_all_entries)
[40.554376] Starting subtest: read_all_entries
[40.805784] Subtest read_all_entries: SUCCESS (0.250s)
[40.893435] [004/171] (959s left) debugfs_test (basic-hwmon)
[40.956400] Starting subtest: basic-hwmon
[40.961028] Subtest basic-hwmon: SUCCESS (0.003s)
[41.043410] [005/171] (958s left) fbdev (eof)
[41.112908] Starting subtest: eof
[41.114361] Subtest eof: SUCCESS (0.000s)
[41.143316] [006/171] (958s left) fbdev (info)
[41.202111] Starting subtest: info
[41.203685] Subtest info: SUCCESS (0.000s)
[41.235229] [007/171] (958s left) fbdev (nullptr)
[41.296127] Starting subtest: nullptr
[41.297802] Subtest nullptr: SUCCESS (0.000s)
[41.327017] [008/171] (958s left) fbdev (read)
[41.387825] Starting subtest: read
[42.832153] Subtest read: SUCCESS (1.441s)
[42.859767] [009/171] (957s left) fbdev (write)
[42.929857] Starting subtest: write
[43.640954] Subtest write: SUCCESS (0.708s)
[43.668392] [010/171] (956s left) gem_basic (bad-close)
[43.730236] Starting subtest: bad-close
[43.742836] Subtest bad-close: SUCCESS (0.000s)
[43.767251] [011/171] (956s left) gem_basic (create-close)
[43.827706] Starting subtest: create-close
[43.831585] Subtest create-close: SUCCESS (0.000s)
[43.896393] [012/171] (956s left) gem_basic (create-fd-close)
[43.963678] Starting subtest: create-fd-close
[43.966781] Subtest create-fd-close: SUCCESS (0.000s)
[44.017322] [013/171] (956s left) gem_busy (busy@all-engines)
[44.090605] Starting subtest: busy
[44.092107] Starting dynamic subtest: all-engines
[44.135673] Dynamic subtest all-engines: SUCCESS (0.045s)
[44.137180] Subtest busy: SUCCESS (0.045s)
[44.556435] [014/171] (955s left) gem_close_race (basic-process)
[44.661898] Starting subtest: basic-process
[44.710110] Subtest basic-process: SUCCESS (0.048s)
[44.878340] [015/171] (955s left) gem_close_race (basic-threads)
[44.961025] Starting subtest: basic-threads
[46.111905] Subtest basic-threads: SUCCESS (1.151s)
[46.356390] [016/171] (953s left) gem_ctx_create (basic)
[46.474784] Starting subtest: basic
[46.476540] Subtest basic: SUCCESS (0.000s)
[46.636924] [017/171] (953s left) gem_ctx_create (basic-files)
[46.723033] Starting subtest: basic-files
[48.734900] Subtest basic-files: SUCCESS (2.012s)
[49.459588] [018/171] (950s left) gem_ctx_exec (basic)
[49.562378] Starting subtest: basic
[49.566667] Subtest basic: SUCCESS (0.004s)
[49.639616] [019/171] (950s left) gem_exec_basic (basic)
[49.734848] Starting subtest: basic
[49.736396] Starting dynamic subtest: rcs0-smem
[49.737954] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[49.744309] Starting dynamic subtest: bcs0-smem
[49.745882] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[49.750992] Starting dynamic subtest: vcs0-smem
[49.752816] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[49.757935] Starting dynamic subtest: vcs1-smem
[49.759688] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[49.764923] Starting dynamic subtest: vecs0-smem
[49.766674] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[49.771911] Starting dynamic subtest: rcs0-lmem0
[49.773693] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[49.779046] Starting dynamic subtest: bcs0-lmem0
[49.780814] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[49.786691] Starting dynamic subtest: vcs0-lmem0
[49.788441] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[49.794851] Starting dynamic subtest: vcs1-lmem0
[49.796608] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[49.803000] Starting dynamic subtest: vecs0-lmem0
[49.804778] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[49.806549] Subtest basic: SUCCESS (0.008s)
[49.938980] [020/171] (950s left) gem_exec_create (basic)
[50.050249] Starting subtest: basic
[50.051806] Starting dynamic subtest: smem
[52.138799] Dynamic subtest smem: SUCCESS (2.090s)
[52.144275] Starting dynamic subtest: lmem0
[54.231812] Dynamic subtest lmem0: SUCCESS (2.093s)
[54.233674] Subtest basic: SUCCESS (4.183s)
[54.409863] [021/171] (945s left) gem_exec_fence (basic-busy)
[54.607546] Starting subtest: basic-busy
[54.609259] Starting dynamic subtest: rcs0
[54.690470] Dynamic subtest rcs0: SUCCESS (0.085s)
[54.698346] Starting dynamic subtest: bcs0
[54.738930] Dynamic subtest bcs0: SUCCESS (0.049s)
[54.751073] Starting dynamic subtest: vcs0
[54.792425] Dynamic subtest vcs0: SUCCESS (0.052s)
[54.815126] Starting dynamic subtest: vcs1
[54.850131] Dynamic subtest vcs1: SUCCESS (0.058s)
[54.872724] Starting dynamic subtest: vecs0
[54.909936] Dynamic subtest vecs0: SUCCESS (0.059s)
[54.912755] Subtest basic-busy: SUCCESS (0.305s)
[55.506287] [022/171] (944s left) gem_exec_fence (basic-wait)
[55.773256] Starting subtest: basic-wait
[55.774842] Starting dynamic subtest: rcs0
[55.846740] Dynamic subtest rcs0: SUCCESS (0.077s)
[55.854753] Starting dynamic subtest: bcs0
[55.894780] Dynamic subtest bcs0: SUCCESS (0.048s)
[55.905553] Starting dynamic subtest: vcs0
[55.951233] Dynamic subtest vcs0: SUCCESS (0.055s)
[55.974859] Starting dynamic subtest: vcs1
[56.011488] Dynamic subtest vcs1: SUCCESS (0.060s)
[56.021413] Starting dynamic subtest: vecs0
[56.057819] Dynamic subtest vecs0: SUCCESS (0.047s)
[56.059720] Subtest basic-wait: SUCCESS (0.289s)
[56.619076] [023/171] (943s left) gem_exec_fence (basic-await)
[56.807326] Starting subtest: basic-await
[56.808956] Starting dynamic subtest: rcs0
[56.893454] Dynamic subtest rcs0: SUCCESS (0.089s)
[56.900290] Starting dynamic subtest: bcs0
[56.972122] Dynamic subtest bcs0: SUCCESS (0.078s)
[56.980411] Starting dynamic subtest: vcs0
[57.055613] Dynamic subtest vcs0: SUCCESS (0.084s)
[57.063117] Starting dynamic subtest: vcs1
[57.138412] Dynamic subtest vcs1: SUCCESS (0.083s)
[57.145251] Starting dynamic subtest: vecs0
[57.217489] Dynamic subtest vecs0: SUCCESS (0.079s)
[57.219112] Subtest basic-await: SUCCESS (0.413s)
[57.739568] [024/171] (942s left) gem_exec_fence (nb-await)
[57.949911] Starting subtest: nb-await
[57.951315] Starting dynamic subtest: rcs0
[58.022357] Dynamic subtest rcs0: SUCCESS (0.075s)
[58.031133] Starting dynamic subtest: bcs0
[58.084674] Dynamic subtest bcs0: SUCCESS (0.062s)
[58.097162] Starting dynamic subtest: vcs0
[58.155914] Dynamic subtest vcs0: SUCCESS (0.070s)
[58.164636] Starting dynamic subtest: vcs1
[58.220624] Dynamic subtest vcs1: SUCCESS (0.064s)
[58.244313] Starting dynamic subtest: vecs0
[58.306971] Dynamic subtest vecs0: SUCCESS (0.086s)
[58.309780] Subtest nb-await: SUCCESS (0.359s)
[58.799015] [025/171] (941s left) gem_exec_gttfill (basic)
[58.872909] Starting subtest: basic
[64.949405] Subtest basic: SUCCESS (6.073s)
[65.192196] [026/171] (935s left) gem_exec_parallel (engines)
[65.320336] Starting subtest: engines
[65.322069] Starting dynamic subtest: basic
[69.516066] Dynamic subtest basic: SUCCESS (4.194s)
[69.542711] Starting dynamic subtest: contexts
[74.200528] Dynamic subtest contexts: SUCCESS (4.681s)
[74.206717] Starting dynamic subtest: fds
[78.447572] Dynamic subtest fds: SUCCESS (4.248s)
[78.453125] Starting dynamic subtest: userptr
[80.278606] Dynamic subtest userptr: SUCCESS (1.833s)
[80.280610] Subtest engines: SUCCESS (14.958s)
[80.523538] [027/171] (919s left) gem_exec_store (basic)
[80.624962] Starting subtest: basic
[80.705870] Subtest basic: SUCCESS (0.081s)
[80.898050] [028/171] (919s left) gem_flink_basic (bad-flink)
[80.957517] Starting subtest: bad-flink
[80.958462] Subtest bad-flink: SUCCESS (0.000s)
[80.990354] [029/171] (919s left) gem_flink_basic (bad-open)
[81.050868] Starting subtest: bad-open
[81.051753] Subtest bad-open: SUCCESS (0.000s)
[81.090075] [030/171] (919s left) gem_flink_basic (basic)
[81.149531] Starting subtest: basic
[81.150458] Subtest basic: SUCCESS (0.000s)
[81.206430] [031/171] (919s left) gem_flink_basic (double-flink)
[81.265978] Starting subtest: double-flink
[81.266964] Subtest double-flink: SUCCESS (0.000s)
[81.315303] [032/171] (919s left) gem_flink_basic (flink-lifetime)
[81.380138] Starting subtest: flink-lifetime
[81.381192] Subtest flink-lifetime: SUCCESS (0.001s)
[81.431387] [033/171] (919s left) gem_huc_copy (huc-copy)
[81.511341] Starting subtest: huc-copy
[81.516426] Subtest huc-copy: SUCCESS (0.005s)
[81.586380] [034/171] (918s left) gem_linear_blits (basic)
[81.737834] Starting subtest: basic
[81.754225] Subtest basic: SUCCESS (0.017s)
[81.849548] [035/171] (918s left) gem_mmap (basic)
[82.007224] Subtest basic: SKIP (0.000s)
[82.024356] [036/171] (918s left) gem_mmap_gtt (basic)
[82.084842] Subtest basic: SKIP (0.000s)
[82.108017] [037/171] (918s left) gem_render_linear_blits (basic)
[82.172493] Starting subtest: basic
[82.237213] Subtest basic: SUCCESS (0.065s)
[82.294121] [038/171] (918s left) gem_render_tiled_blits (basic)
[82.373524] Subtest basic: SKIP (0.000s)
[82.391070] [039/171] (918s left) gem_ringfill (basic-all)
[82.797428] Starting subtest: basic-all
[84.160449] Subtest basic-all: SUCCESS (1.361s)
[84.269603] [040/171] (916s left) gem_softpin (allocator-basic)
[84.372557] Starting subtest: allocator-basic
[84.561407] Subtest allocator-basic: SUCCESS (0.186s)
[84.636338] [041/171] (915s left) gem_softpin (allocator-basic-reserve)
[84.703478] Starting subtest: allocator-basic-reserve
[84.894697] Subtest allocator-basic-reserve: SUCCESS (0.188s)
[84.970190] [042/171] (915s left) gem_softpin (safe-alignment)
[85.060396] Starting subtest: safe-alignment
[85.090282] Subtest safe-alignment: SUCCESS (0.030s)
[85.176738] [043/171] (915s left) gem_sync (basic-all)
[85.274939] Starting subtest: basic-all
[87.581062] Subtest basic-all: SUCCESS (2.307s)
[87.742279] [044/171] (912s left) gem_sync (basic-each)
[87.813093] Starting subtest: basic-each
[90.056156] Subtest basic-each: SUCCESS (2.244s)
[90.215549] [045/171] (910s left) gem_tiled_blits (basic)
[90.296942] Subtest basic: SKIP (0.000s)
[90.316149] [046/171] (910s left) gem_tiled_fence_blits (basic)
[90.381325] Subtest basic: SKIP (0.000s)
[90.399063] [047/171] (910s left) gem_tiled_pread_basic
[90.483093] [048/171] (910s left) gem_wait (busy@all-engines)
[90.553609] Starting subtest: busy
[90.554446] Starting dynamic subtest: all-engines
[91.111195] Dynamic subtest all-engines: SUCCESS (0.557s)
[91.112066] Subtest busy: SUCCESS (0.558s)
[91.325355] [049/171] (909s left) gem_wait (wait@all-engines)
[91.408840] Starting subtest: wait
[91.409687] Starting dynamic subtest: all-engines
[92.481252] Dynamic subtest all-engines: SUCCESS (1.072s)
[92.482254] Subtest wait: SUCCESS (1.072s)
[92.685553] [050/171] (908s left) i915_getparams_basic (basic-eu-total)
[92.747657] Starting subtest: basic-eu-total
[92.749391] Subtest basic-eu-total: SUCCESS (0.000s)
[92.781652] [051/171] (907s left) i915_getparams_basic (basic-subslice-total)
[92.841385] Starting subtest: basic-subslice-total
[92.843137] Subtest basic-subslice-total: SUCCESS (0.000s)
[92.881410] [052/171] (907s left) i915_hangman (error-state-basic)
[92.951784] Starting subtest: error-state-basic
[93.067262] Subtest error-state-basic: SUCCESS (0.116s)
[93.106757] [053/171] (907s left) i915_pciid
[93.206496] [054/171] (907s left) kms_addfb_basic (addfb25-bad-modifier)
[93.317420] Starting subtest: addfb25-bad-modifier
[93.318429] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[93.473710] [055/171] (907s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[93.584662] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[93.740543] [056/171] (907s left) kms_addfb_basic (addfb25-modifier-no-flag)
[93.850234] Starting subtest: addfb25-modifier-no-flag
[93.851139] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[94.007103] [057/171] (906s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[94.118681] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[94.273789] [058/171] (906s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[94.384110] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[94.540631] [059/171] (906s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[94.699093] Starting subtest: addfb25-yf-tiled-legacy
[94.700287] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[94.799235] [060/171] (906s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[94.956392] Starting subtest: addfb25-y-tiled-legacy
[94.957282] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[95.057200] [061/171] (905s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[95.213651] Starting subtest: addfb25-y-tiled-small-legacy
[95.214725] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[95.323551] [062/171] (905s left) kms_addfb_basic (bad-pitch-0)
[95.384565] Starting subtest: bad-pitch-0
[95.385585] Subtest bad-pitch-0: SUCCESS (0.000s)
[95.590439] [063/171] (905s left) kms_addfb_basic (bad-pitch-1024)
[95.651594] Starting subtest: bad-pitch-1024
[95.652525] Subtest bad-pitch-1024: SUCCESS (0.000s)
[95.849270] [064/171] (905s left) kms_addfb_basic (bad-pitch-128)
[95.910400] Starting subtest: bad-pitch-128
[95.911523] Subtest bad-pitch-128: SUCCESS (0.000s)
[96.106839] [065/171] (904s left) kms_addfb_basic (bad-pitch-256)
[96.167310] Starting subtest: bad-pitch-256
[96.168307] Subtest bad-pitch-256: SUCCESS (0.000s)
[96.373990] [066/171] (904s left) kms_addfb_basic (bad-pitch-32)
[96.435374] Starting subtest: bad-pitch-32
[96.436319] Subtest bad-pitch-32: SUCCESS (0.000s)
[96.640256] [067/171] (904s left) kms_addfb_basic (bad-pitch-63)
[96.701470] Starting subtest: bad-pitch-63
[96.702502] Subtest bad-pitch-63: SUCCESS (0.000s)
[96.907060] [068/171] (904s left) kms_addfb_basic (bad-pitch-65536)
[96.968564] Starting subtest: bad-pitch-65536
[96.969724] Subtest bad-pitch-65536: SUCCESS (0.000s)
[97.166009] [069/171] (903s left) kms_addfb_basic (bad-pitch-999)
[97.229963] Starting subtest: bad-pitch-999
[97.230975] Subtest bad-pitch-999: SUCCESS (0.000s)
[97.415240] [070/171] (903s left) kms_addfb_basic (basic)
[97.476366] Starting subtest: basic
[97.477300] Subtest basic: SUCCESS (0.000s)
[97.682142] [071/171] (903s left) kms_addfb_basic (basic-x-tiled-legacy)
[97.884745] Starting subtest: basic-x-tiled-legacy
[97.886601] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[97.949336] [072/171] (903s left) kms_addfb_basic (basic-y-tiled-legacy)
[98.151895] Starting subtest: basic-y-tiled-legacy
[98.154050] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[98.215562] [073/171] (902s left) kms_addfb_basic (bo-too-small)
[98.325208] Starting subtest: bo-too-small
[98.326386] Subtest bo-too-small: SUCCESS (0.000s)
[98.481877] [074/171] (902s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[98.590521] Starting subtest: bo-too-small-due-to-tiling
[98.592486] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[98.740221] [075/171] (902s left) kms_addfb_basic (clobberred-modifier)
[98.801114] Starting subtest: clobberred-modifier
[98.803041] Subtest clobberred-modifier: SKIP (0.000s)
[99.006998] [076/171] (902s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[99.209239] Starting subtest: framebuffer-vs-set-tiling
[99.211323] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[99.266097] [077/171] (901s left) kms_addfb_basic (invalid-get-prop)
[99.467031] Starting subtest: invalid-get-prop
[99.468110] Subtest invalid-get-prop: SUCCESS (0.000s)
[99.506976] [078/171] (901s left) kms_addfb_basic (invalid-get-prop-any)
[99.710395] Starting subtest: invalid-get-prop-any
[99.711396] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[99.781893] [079/171] (901s left) kms_addfb_basic (invalid-set-prop)
[99.983010] Starting subtest: invalid-set-prop
[99.983909] Subtest invalid-set-prop: SUCCESS (0.000s)
[100.032095] [080/171] (901s left) kms_addfb_basic (invalid-set-prop-any)
[100.234842] Starting subtest: invalid-set-prop-any
[100.235829] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[100.290623] [081/171] (900s left) kms_addfb_basic (no-handle)
[100.352107] Starting subtest: no-handle
[100.353112] Subtest no-handle: SUCCESS (0.000s)
[100.557328] [082/171] (900s left) kms_addfb_basic (size-max)
[100.667294] Starting subtest: size-max
[100.668421] Subtest size-max: SUCCESS (0.000s)
[100.815751] [083/171] (900s left) kms_addfb_basic (small-bo)
[100.925815] Starting subtest: small-bo
[100.926753] Subtest small-bo: SUCCESS (0.000s)
[101.090379] [084/171] (900s left) kms_addfb_basic (tile-pitch-mismatch)
[101.293605] Starting subtest: tile-pitch-mismatch
[101.295589] Subtest tile-pitch-mismatch: SKIP (0.000s)
[101.349128] [085/171] (899s left) kms_addfb_basic (too-high)
[101.460072] Starting subtest: too-high
[101.461061] Subtest too-high: SUCCESS (0.000s)
[101.615600] [086/171] (899s left) kms_addfb_basic (too-wide)
[101.725349] Starting subtest: too-wide
[101.726481] Subtest too-wide: SUCCESS (0.000s)
[101.865662] [087/171] (899s left) kms_addfb_basic (unused-handle)
[101.926528] Starting subtest: unused-handle
[101.927578] Subtest unused-handle: SUCCESS (0.000s)
[102.124049] [088/171] (899s left) kms_addfb_basic (unused-modifier)
[102.185967] Starting subtest: unused-modifier
[102.186931] Subtest unused-modifier: SUCCESS (0.000s)
[102.390256] [089/171] (898s left) kms_addfb_basic (unused-offsets)
[102.452400] Starting subtest: unused-offsets
[102.453407] Subtest unused-offsets: SUCCESS (0.000s)
[102.640321] [090/171] (898s left) kms_addfb_basic (unused-pitches)
[102.702374] Starting subtest: unused-pitches
[102.703416] Subtest unused-pitches: SUCCESS (0.000s)
[102.915528] [091/171] (898s left) kms_busy (basic)
[103.033279] Starting subtest: basic
[103.034321] Starting dynamic subtest: flip
[103.449018] Dynamic subtest flip: SUCCESS (0.414s)
[103.455601] Starting dynamic subtest: modeset
[103.990153] Dynamic subtest modeset: SUCCESS (0.541s)
[103.991772] Subtest basic: SUCCESS (0.958s)
[104.106165] [092/171] (897s left) kms_chamelium_hpd (dp-hpd-fast)
[104.266242] Subtest dp-hpd-fast: SKIP (0.000s)
[104.323468] [093/171] (896s left) kms_chamelium_edid (dp-edid-read)
[104.480546] Subtest dp-edid-read: SKIP (0.000s)
[104.538928] [094/171] (896s left) kms_chamelium_frames (dp-crc-fast)
[104.696756] Subtest dp-crc-fast: SKIP (0.000s)
[104.754990] [095/171] (896s left) kms_chamelium_hpd (hdmi-hpd-fast)
[104.911198] Subtest hdmi-hpd-fast: SKIP (0.000s)
[104.969032] [096/171] (896s left) kms_chamelium_edid (hdmi-edid-read)
[105.126623] Subtest hdmi-edid-read: SKIP (0.000s)
[105.184155] [097/171] (896s left) kms_chamelium_frames (hdmi-crc-fast)
[105.342339] Subtest hdmi-crc-fast: SKIP (0.000s)
[105.400455] [098/171] (895s left) kms_chamelium_hpd (vga-hpd-fast)
[105.556611] Subtest vga-hpd-fast: SKIP (0.000s)
[105.614007] [099/171] (895s left) kms_chamelium_edid (vga-edid-read)
[105.772397] Subtest vga-edid-read: SKIP (0.000s)
[105.829379] [100/171] (895s left) kms_prop_blob (basic)
[105.890701] Starting subtest: basic
[105.891665] Subtest basic: SUCCESS (0.000s)
[105.925463] [101/171] (895s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[106.035304] Starting subtest: basic-busy-flip-before-cursor-atomic
[106.037347] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[106.075417] [102/171] (895s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[106.184852] Starting subtest: basic-busy-flip-before-cursor-legacy
[106.186425] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[106.225098] [103/171] (895s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[106.335424] Starting subtest: basic-flip-after-cursor-atomic
[106.892753] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.558s)
[107.007426] [104/171] (894s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[107.117493] Starting subtest: basic-flip-after-cursor-legacy
[107.679796] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.557s)
[107.793150] [105/171] (893s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[107.901817] Starting subtest: basic-flip-after-cursor-varying-size
[108.499681] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.559s)
[108.641722] [106/171] (892s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[108.831582] Starting subtest: basic-flip-before-cursor-atomic
[109.351635] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.553s)
[109.476069] [107/171] (892s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[109.586233] Starting subtest: basic-flip-before-cursor-legacy
[110.136569] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.549s)
[110.254073] [108/171] (891s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[110.364475] Starting subtest: basic-flip-before-cursor-varying-size
[110.935010] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.565s)
[111.044902] [109/171] (890s left) kms_flip (basic-flip-vs-dpms)
[111.136577] Starting subtest: basic-flip-vs-dpms
[111.143217] Starting dynamic subtest: A-HDMI-A2
[111.913146] Dynamic subtest A-HDMI-A2: SUCCESS (0.770s)
[111.919281] Starting dynamic subtest: B-HDMI-A2
[112.650131] Dynamic subtest B-HDMI-A2: SUCCESS (0.736s)
[112.656290] Starting dynamic subtest: C-HDMI-A2
[113.342461] Dynamic subtest C-HDMI-A2: SUCCESS (0.691s)
[113.348733] Starting dynamic subtest: D-HDMI-A2
[113.986167] Dynamic subtest D-HDMI-A2: SUCCESS (0.644s)
[113.989332] Subtest basic-flip-vs-dpms: SUCCESS (2.854s)
[114.105672] [110/171] (887s left) kms_flip (basic-flip-vs-modeset)
[114.199604] Starting subtest: basic-flip-vs-modeset
[114.204837] Starting dynamic subtest: A-HDMI-A2
[114.994218] Dynamic subtest A-HDMI-A2: SUCCESS (0.789s)
[115.002243] Starting dynamic subtest: B-HDMI-A2
[115.668678] Dynamic subtest B-HDMI-A2: SUCCESS (0.673s)
[115.676087] Starting dynamic subtest: C-HDMI-A2
[116.379621] Dynamic subtest C-HDMI-A2: SUCCESS (0.710s)
[116.386056] Starting dynamic subtest: D-HDMI-A2
[117.047709] Dynamic subtest D-HDMI-A2: SUCCESS (0.667s)
[117.050458] Subtest basic-flip-vs-modeset: SUCCESS (2.854s)
[117.162270] [111/171] (884s left) kms_flip (basic-flip-vs-wf_vblank)
[117.255950] Starting subtest: basic-flip-vs-wf_vblank
[117.262246] Starting dynamic subtest: A-HDMI-A2
[118.208849] Dynamic subtest A-HDMI-A2: SUCCESS (0.947s)
[118.215521] Starting dynamic subtest: B-HDMI-A2
[119.106341] Dynamic subtest B-HDMI-A2: SUCCESS (0.897s)
[119.112913] Starting dynamic subtest: C-HDMI-A2
[119.998095] Dynamic subtest C-HDMI-A2: SUCCESS (0.891s)
[120.004561] Starting dynamic subtest: D-HDMI-A2
[120.883885] Dynamic subtest D-HDMI-A2: SUCCESS (0.885s)
[120.887228] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.633s)
[121.032595] [112/171] (880s left) kms_flip (basic-plain-flip)
[121.125285] Starting subtest: basic-plain-flip
[121.132620] Starting dynamic subtest: A-HDMI-A2
[121.862676] Dynamic subtest A-HDMI-A2: SUCCESS (0.730s)
[121.869047] Starting dynamic subtest: B-HDMI-A2
[122.543592] Dynamic subtest B-HDMI-A2: SUCCESS (0.680s)
[122.550051] Starting dynamic subtest: C-HDMI-A2
[123.218421] Dynamic subtest C-HDMI-A2: SUCCESS (0.674s)
[123.224958] Starting dynamic subtest: D-HDMI-A2
[123.887320] Dynamic subtest D-HDMI-A2: SUCCESS (0.668s)
[123.890552] Subtest basic-plain-flip: SUCCESS (2.766s)
[124.044227] [113/171] (877s left) kms_force_connector_basic (force-connector-state)
[124.163865] Starting subtest: force-connector-state
[125.981634] Subtest force-connector-state: SUCCESS (1.817s)
[126.336232] [114/171] (875s left) kms_force_connector_basic (force-edid)
[126.456591] Starting subtest: force-edid
[126.470172] Subtest force-edid: SUCCESS (0.014s)
[126.619809] [115/171] (874s left) kms_force_connector_basic (force-load-detect)
[126.741044] Starting subtest: force-load-detect
[126.742960] Subtest force-load-detect: SKIP (0.000s)
[126.885698] [116/171] (874s left) kms_force_connector_basic (prune-stale-modes)
[127.004542] Starting subtest: prune-stale-modes
[127.016919] Subtest prune-stale-modes: SUCCESS (0.011s)
[127.169633] [117/171] (874s left) kms_frontbuffer_tracking (basic)
[127.284204] Starting subtest: basic
[129.228471] Subtest basic: SUCCESS (1.946s)
[129.277981] [118/171] (872s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[129.390494] Starting subtest: compare-crc-sanitycheck
[129.391536] Starting dynamic subtest: pipe-A-HDMI-A-2
[129.668805] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.278s)
[129.676815] Starting dynamic subtest: pipe-B-HDMI-A-2
[130.335815] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.663s)
[130.344688] Starting dynamic subtest: pipe-C-HDMI-A-2
[131.384414] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.048s)
[131.392853] Starting dynamic subtest: pipe-D-HDMI-A-2
[132.449818] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (1.063s)
[132.450760] Subtest compare-crc-sanitycheck: SUCCESS (3.060s)
[132.543729] [119/171] (869s left) kms_pipe_crc_basic (hang-read-crc)
[132.657105] Starting subtest: hang-read-crc
[132.659193] Starting dynamic subtest: pipe-A-HDMI-A-2
[133.529786] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.872s)
[133.537012] Starting dynamic subtest: pipe-B-HDMI-A-2
[135.133580] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.601s)
[135.140428] Starting dynamic subtest: pipe-C-HDMI-A-2
[137.489171] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.354s)
[137.496265] Starting dynamic subtest: pipe-D-HDMI-A-2
[140.600159] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (3.108s)
[140.601840] Subtest hang-read-crc: SUCCESS (7.943s)
[140.736956] [120/171] (860s left) kms_pipe_crc_basic (nonblocking-crc)
[140.850494] Starting subtest: nonblocking-crc
[140.851462] Starting dynamic subtest: pipe-A-HDMI-A-2
[141.219304] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.368s)
[141.226951] Starting dynamic subtest: pipe-B-HDMI-A-2
[141.961553] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.741s)
[141.968816] Starting dynamic subtest: pipe-C-HDMI-A-2
[143.084947] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.121s)
[143.092361] Starting dynamic subtest: pipe-D-HDMI-A-2
[144.578673] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (1.490s)
[144.579746] Subtest nonblocking-crc: SUCCESS (3.727s)
[144.685173] [121/171] (856s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[144.797443] Starting subtest: nonblocking-crc-frame-sequence
[144.798453] Starting dynamic subtest: pipe-A-HDMI-A-2
[145.159710] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.362s)
[145.167812] Starting dynamic subtest: pipe-B-HDMI-A-2
[145.901034] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.739s)
[145.908984] Starting dynamic subtest: pipe-C-HDMI-A-2
[147.023692] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.120s)
[147.030235] Starting dynamic subtest: pipe-D-HDMI-A-2
[148.514845] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (1.489s)
[148.515708] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.718s)
[148.621096] [122/171] (853s left) kms_pipe_crc_basic (read-crc)
[148.739462] Starting subtest: read-crc
[148.740422] Starting dynamic subtest: pipe-A-HDMI-A-2
[149.071171] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.330s)
[149.078415] Starting dynamic subtest: pipe-B-HDMI-A-2
[149.779125] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.706s)
[149.786148] Starting dynamic subtest: pipe-C-HDMI-A-2
[150.867109] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.085s)
[150.873460] Starting dynamic subtest: pipe-D-HDMI-A-2
[152.327191] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (1.459s)
[152.328123] Subtest read-crc: SUCCESS (3.589s)
[152.443685] [123/171] (849s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[152.556155] Starting subtest: read-crc-frame-sequence
[152.557042] Starting dynamic subtest: pipe-A-HDMI-A-2
[152.892744] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.336s)
[152.900746] Starting dynamic subtest: pipe-B-HDMI-A-2
[153.601055] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.706s)
[153.608873] Starting dynamic subtest: pipe-C-HDMI-A-2
[154.690125] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.087s)
[154.697501] Starting dynamic subtest: pipe-D-HDMI-A-2
[156.148451] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (1.456s)
[156.149573] Subtest read-crc-frame-sequence: SUCCESS (3.594s)
[156.261197] [124/171] (845s left) kms_psr (primary_page_flip)
[156.327314] Subtest primary_page_flip: SKIP (0.000s)
[156.351756] [125/171] (845s left) kms_psr (cursor_plane_move)
[156.414615] Subtest cursor_plane_move: SKIP (0.000s)
[156.435247] [126/171] (845s left) kms_psr (sprite_plane_onoff)
[156.498379] Subtest sprite_plane_onoff: SKIP (0.000s)
[156.518785] [127/171] (845s left) kms_psr (primary_mmap_gtt)
[156.580459] Subtest primary_mmap_gtt: SKIP (0.000s)
[156.601945] [128/171] (845s left) kms_setmode (basic-clone-single-crtc)
[156.665840] Starting subtest: basic-clone-single-crtc
[156.668874] Subtest basic-clone-single-crtc: SKIP (0.001s)
[156.708720] [129/171] (845s left) i915_pm_backlight (basic-brightness)
[156.821672] Subtest basic-brightness: SKIP (0.000s)
[156.843410] [130/171] (844s left) i915_pm_rpm (basic-pci-d3-state)
[159.007150] Starting subtest: basic-pci-d3-state
[159.744554] Subtest basic-pci-d3-state: SUCCESS (0.740s)
[159.983667] [131/171] (841s left) i915_pm_rpm (basic-rte)
[160.044803] Starting subtest: basic-rte
[162.546149] Subtest basic-rte: SUCCESS (2.501s)
[163.268999] [132/171] (838s left) i915_pm_rps (basic-api)
[163.335480] Starting subtest: basic-api
[163.337125] Subtest basic-api: SKIP (0.000s)
[163.377100] [133/171] (838s left) prime_self_import (basic-llseek-bad)
[163.436424] Starting subtest: basic-llseek-bad
[163.438869] Subtest basic-llseek-bad: SUCCESS (0.002s)
[163.501478] [134/171] (838s left) prime_self_import (basic-llseek-size)
[163.561248] Starting subtest: basic-llseek-size
[163.563497] Subtest basic-llseek-size: SUCCESS (0.002s)
[163.618104] [135/171] (838s left) prime_self_import (basic-with_fd_dup)
[163.677418] Starting subtest: basic-with_fd_dup
[163.680025] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[163.743491] [136/171] (838s left) prime_self_import (basic-with_one_bo)
[163.803524] Starting subtest: basic-with_one_bo
[163.807299] Subtest basic-with_one_bo: SUCCESS (0.003s)
[163.836645] [137/171] (838s left) prime_self_import (basic-with_one_bo_two_files)
[163.896570] Starting subtest: basic-with_one_bo_two_files
[163.899167] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[163.960069] [138/171] (837s left) prime_self_import (basic-with_two_bos)
[164.020261] Starting subtest: basic-with_two_bos
[164.022691] Subtest basic-with_two_bos: SUCCESS (0.003s)
[164.085161] [139/171] (837s left) prime_vgem (basic-fence-flip)
[164.158308] Starting subtest: basic-fence-flip
[164.219484] Subtest basic-fence-flip: SKIP (0.060s)
[164.285223] [140/171] (837s left) prime_vgem (basic-fence-mmap)
[164.358362] Starting subtest: basic-fence-mmap
[164.360366] Subtest basic-fence-mmap: SKIP (0.000s)
[164.418837] [141/171] (837s left) prime_vgem (basic-fence-read)
[164.491525] Starting subtest: basic-fence-read
[164.497433] Subtest basic-fence-read: SKIP (0.005s)
[164.567916] [142/171] (837s left) prime_vgem (basic-gtt)
[164.641720] Starting subtest: basic-gtt
[164.643448] Subtest basic-gtt: SKIP (0.000s)
[164.701368] [143/171] (837s left) prime_vgem (basic-read)
[164.774881] Starting subtest: basic-read
[164.780693] Subtest basic-read: SKIP (0.005s)
[164.860216] [144/171] (837s left) prime_vgem (basic-write)
[164.949049] Starting subtest: basic-write
[164.954930] Subtest basic-write: SKIP (0.005s)
[165.018518] [145/171] (836s left) prime_vgem (basic-userptr)
[165.091725] Starting subtest: basic-userptr
[165.098335] Subtest basic-userptr: SKIP (0.006s)
[165.146638] [146/171] (836s left) vgem_basic (setversion)
[165.211180] Starting subtest: setversion
[165.213192] Subtest setversion: SUCCESS (0.000s)
[165.243242] [147/171] (836s left) vgem_basic (create)
[165.311290] Starting subtest: create
[165.312304] Subtest create: SUCCESS (0.000s)
[165.343490] [148/171] (836s left) vgem_basic (debugfs)
[165.411295] Starting subtest: debugfs
[165.412315] Subtest debugfs: SUCCESS (0.000s)
[165.444158] [149/171] (836s left) vgem_basic (dmabuf-export)
[165.511248] Starting subtest: dmabuf-export
[165.513822] Subtest dmabuf-export: SUCCESS (0.002s)
[165.585182] [150/171] (836s left) vgem_basic (dmabuf-fence)
[165.653068] Starting subtest: dmabuf-fence
[165.654056] Subtest dmabuf-fence: SUCCESS (0.000s)
[165.685626] [151/171] (836s left) vgem_basic (dmabuf-fence-before)
[165.753106] Starting subtest: dmabuf-fence-before
[165.754067] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[165.785328] [152/171] (836s left) vgem_basic (dmabuf-mmap)
[165.852809] Starting subtest: dmabuf-mmap
[165.864311] Subtest dmabuf-mmap: SUCCESS (0.011s)
[165.893210] [153/171] (836s left) vgem_basic (mmap)
[165.961150] Starting subtest: mmap
[165.968793] Subtest mmap: SUCCESS (0.008s)
[166.001874] [154/171] (836s left) vgem_basic (second-client)
[166.069530] Starting subtest: second-client
[166.094013] Subtest second-client: SUCCESS (0.024s)
[166.126935] [155/171] (836s left) vgem_basic (sysfs)
[166.194670] Starting subtest: sysfs
[166.195623] Subtest sysfs: SUCCESS (0.000s)
[166.226573] [156/171] (835s left) core_hotunplug (unbind-rebind)
[166.302779] Starting subtest: unbind-rebind
[167.596524] Subtest unbind-rebind: SUCCESS (1.293s)
[167.612466] [157/171] (834s left) vgem_basic (unload)
[167.675544] Starting subtest: unload
[196.398197] Subtest unload: SUCCESS (28.720s)
[196.461261] [158/171] (805s left) i915_module_load (reload)
[196.522889] Starting subtest: reload
[198.236475] Subtest reload: SUCCESS (1.714s)
[198.263317] [159/171] (803s left) gem_lmem_swapping (basic)
[199.712256] Starting subtest: basic
[199.712975] Starting dynamic subtest: lmem0
[218.990252] Dynamic subtest lmem0: SUCCESS (19.274s)
[218.991191] Subtest basic: SUCCESS (19.274s)
[220.453315] [160/171] (781s left) gem_lmem_swapping (parallel-random-engines)
[220.996396] Starting subtest: parallel-random-engines
[220.997332] Starting dynamic subtest: lmem0
[221.913944] Dynamic subtest lmem0: SUCCESS (0.915s)
[221.914973] Subtest parallel-random-engines: SUCCESS (0.916s)
[222.836535] [161/171] (779s left) gem_lmem_swapping (random-engines)
[223.356762] Starting subtest: random-engines
[223.357608] Starting dynamic subtest: lmem0
[224.212043] Dynamic subtest lmem0: SUCCESS (0.852s)
[224.212968] Subtest random-engines: SUCCESS (0.852s)
[225.153681] [162/171] (777s left) gem_lmem_swapping (verify-random)
[225.668833] Starting subtest: verify-random
[225.670142] Starting dynamic subtest: lmem0
[235.023290] Dynamic subtest lmem0: SUCCESS (9.351s)
[235.024209] Subtest verify-random: SUCCESS (9.351s)
[236.067534] [163/171] (766s left) i915_pm_rpm (module-reload)
[238.346406] Starting subtest: module-reload
[247.671717] Subtest module-reload: SUCCESS (9.322s)
[247.685492] [164/171] (754s left) i915_selftest (live)
[247.751248] Starting subtest: live
[247.752131] Starting dynamic subtest: sanitycheck
[248.563927] Dynamic subtest sanitycheck: SUCCESS (0.809s)
[248.569348] Starting dynamic subtest: uncore
[249.402798] Dynamic subtest uncore: SUCCESS (0.838s)
[249.407790] Starting dynamic subtest: workarounds
[251.768891] Dynamic subtest workarounds: SUCCESS (2.365s)
[251.774137] Starting dynamic subtest: gt_engines
[253.139805] Dynamic subtest gt_engines: SUCCESS (1.370s)
[253.144875] Starting dynamic subtest: gt_timelines
[296.188833] Dynamic subtest gt_timelines: SUCCESS (43.048s)
[296.193976] Starting dynamic subtest: gt_contexts
[297.027787] Dynamic subtest gt_contexts: SUCCESS (0.838s)
[297.033052] Starting dynamic subtest: gt_lrc
[303.242013] Dynamic subtest gt_lrc: SUCCESS (6.213s)
[303.247201] Starting dynamic subtest: gt_mocs
[304.768808] Dynamic subtest gt_mocs: SUCCESS (1.526s)
[304.774153] Starting dynamic subtest: gt_pm
[306.476939] Dynamic subtest gt_pm: SUCCESS (1.708s)
[306.482015] Starting dynamic subtest: gt_heartbeat
[307.461061] Dynamic subtest gt_heartbeat: SUCCESS (0.983s)
[307.466184] Starting dynamic subtest: requests
[317.535910] Dynamic subtest requests: SUCCESS (10.074s)
[317.541125] Starting dynamic subtest: migrate
[321.409832] Dynamic subtest migrate: SUCCESS (3.873s)
[321.414949] Starting dynamic subtest: active
[322.214028] Dynamic subtest active: SUCCESS (0.803s)
[322.219260] Starting dynamic subtest: objects
[324.154876] Dynamic subtest objects: SUCCESS (1.940s)
[324.160038] Starting dynamic subtest: mman
[327.467972] Dynamic subtest mman: SUCCESS (3.312s)
[327.473188] Starting dynamic subtest: dmabuf
[328.372929] Dynamic subtest dmabuf: SUCCESS (0.904s)
[328.378152] Starting dynamic subtest: vma
[329.184939] Dynamic subtest vma: SUCCESS (0.811s)
[329.190276] Starting dynamic subtest: coherency
[338.385883] Dynamic subtest coherency: SUCCESS (9.200s)
[338.390951] Starting dynamic subtest: gtt
[350.136758] Dynamic subtest gtt: SUCCESS (11.750s)
[350.141900] Starting dynamic subtest: gem
[351.016943] Dynamic subtest gem: SUCCESS (0.880s)
[351.022130] Starting dynamic subtest: evict
[363.088839] Dynamic subtest evict: SUCCESS (12.071s)
[363.093946] Starting dynamic subtest: hugepages
[379.038053] Dynamic subtest hugepages: SUCCESS (15.949s)
[379.043326] Starting dynamic subtest: gem_contexts
[405.324877] Dynamic subtest gem_contexts: SUCCESS (26.286s)
[405.330289] Starting dynamic subtest: client
[406.160089] Dynamic subtest client: SUCCESS (0.835s)
[406.165239] Starting dynamic subtest: gem_migrate
[408.090790] Dynamic subtest gem_migrate: SUCCESS (1.930s)
[408.095964] Starting dynamic subtest: reset
[408.949961] Dynamic subtest reset: SUCCESS (0.859s)
[408.955212] Starting dynamic subtest: memory_region
[411.326894] Dynamic subtest memory_region: SUCCESS (2.376s)
[411.332265] Starting dynamic subtest: hangcheck
[438.951846] Dynamic subtest hangcheck: SUCCESS (27.624s)
[438.957076] Starting dynamic subtest: execlists
[439.744862] Dynamic subtest execlists: SUCCESS (0.792s)
[439.750055] Starting dynamic subtest: ring_submission
[440.545720] Dynamic subtest ring_submission: SUCCESS (0.800s)
[440.550800] Starting dynamic subtest: perf
[441.461621] Dynamic subtest perf: SUCCESS (0.915s)
[441.466863] Starting dynamic subtest: slpc
[446.756948] Dynamic subtest slpc: SUCCESS (5.295s)
[446.762282] Starting dynamic subtest: guc
[449.484880] Dynamic subtest guc: SUCCESS (2.727s)
[449.490106] Starting dynamic subtest: guc_multi_lrc
[450.313838] Dynamic subtest guc_multi_lrc: SUCCESS (0.828s)
[450.319111] Starting dynamic subtest: guc_hang
[451.823869] Dynamic subtest guc_hang: SUCCESS (1.509s)
[451.829125] Starting dynamic subtest: late_gt_pm
[452.650047] Dynamic subtest late_gt_pm: SUCCESS (0.826s)
[452.651107] Subtest live: SUCCESS (204.896s)
[452.727211] [165/171] (549s left) dmabuf (all-tests)
[452.788931] Starting subtest: all-tests
[452.790236] Starting dynamic subtest: sanitycheck
[452.820161] Dynamic subtest sanitycheck: SUCCESS (0.031s)
[452.825584] Starting dynamic subtest: dma_fence
[452.948223] Dynamic subtest dma_fence: SUCCESS (0.128s)
[452.953435] Starting dynamic subtest: dma_fence_chain
[465.859173] Dynamic subtest dma_fence_chain: SUCCESS (12.907s)
[465.864109] Starting dynamic subtest: dma_fence_unwrap
[465.879157] Dynamic subtest dma_fence_unwrap: SUCCESS (0.022s)
[465.885104] Starting dynamic subtest: dma_resv
[465.899182] Dynamic subtest dma_resv: SUCCESS (0.019s)
[465.900078] Subtest all-tests: SUCCESS (13.111s)
[465.911815] [166/171] (536s left) i915_suspend (basic-s2idle-without-i915)
[465.974218] Starting subtest: basic-s2idle-without-i915
[484.064754] Subtest basic-s2idle-without-i915: SUCCESS (3.086s)
[489.197021] [167/171] (533s left) i915_suspend (basic-s3-without-i915)
[489.256934] Starting subtest: basic-s3-without-i915
[516.159891] Subtest basic-s3-without-i915: SUCCESS (9.987s)
[520.829616] [168/171] (523s left) gem_exec_suspend (basic-s0)
[520.916219] Starting subtest: basic-S0
[520.917126] Starting dynamic subtest: smem
[540.706578] Dynamic subtest smem: SUCCESS (4.639s)
[540.717586] Starting dynamic subtest: lmem0
[559.683037] Dynamic subtest lmem0: SUCCESS (4.253s)
[559.684173] Subtest basic-S0: SUCCESS (8.894s)
[562.859631] [169/171] (513s left) gem_exec_suspend (basic-s3)
[562.929552] Starting subtest: basic-S3
[562.930450] Starting dynamic subtest: smem
[591.780144] Dynamic subtest smem: SUCCESS (11.898s)
[591.798026] Starting dynamic subtest: lmem0
[620.774589] Dynamic subtest lmem0: SUCCESS (11.650s)
[620.776196] Subtest basic-S3: SUCCESS (23.550s)
[622.968524] [170/171] (490s left) kms_chamelium_hpd (common-hpd-after-suspend)
[623.127364] Subtest common-hpd-after-suspend: SKIP (0.000s)
[623.184528] [171/171] (489s left) kms_pipe_crc_basic (suspend-read-crc)
[623.295392] Starting subtest: suspend-read-crc
[623.296327] Starting dynamic subtest: pipe-A-HDMI-A-2
[650.120883] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (9.567s)
[650.129379] Starting dynamic subtest: pipe-B-HDMI-A-2
[677.473556] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (10.012s)
[677.482106] Starting dynamic subtest: pipe-C-HDMI-A-2
[705.874570] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (10.821s)
[705.884978] Starting dynamic subtest: pipe-D-HDMI-A-2
[734.215783] Dynamic subtest pipe-D-HDMI-A-2: SUCCESS (11.519s)
[734.217316] Subtest suspend-read-crc: SUCCESS (41.927s)
[737.307301] Closing watchdogs
Done.