[34.313859] Initializing watchdogs
[34.314083]   /dev/watchdog0
[34.363220] [001/171] (960s left) i915_module_load (load)
[34.521208] Starting subtest: load
[35.932178] Subtest load: SUCCESS (1.393s)
[36.067107] [002/171] (958s left) core_auth (basic-auth)
[36.226784] Starting subtest: basic-auth
[36.246554] Subtest basic-auth: SUCCESS (0.000s)
[36.318475] [003/171] (958s left) debugfs_test (read_all_entries)
[36.452730] Starting subtest: read_all_entries
[36.492261] Subtest read_all_entries: SUCCESS (0.040s)
[36.564407] [004/171] (958s left) debugfs_test (basic-hwmon)
[36.702655] Starting subtest: basic-hwmon
[36.739842] Subtest basic-hwmon: SKIP (0.000s)
[36.818369] [005/171] (958s left) fbdev (eof)
[36.963553] Starting subtest: eof
[36.985535] Subtest eof: SUCCESS (0.000s)
[37.062618] [006/171] (958s left) fbdev (info)
[37.182145] Starting subtest: info
[37.204210] Subtest info: SUCCESS (0.000s)
[37.280320] [007/171] (957s left) fbdev (nullptr)
[37.405967] Starting subtest: nullptr
[37.428045] Subtest nullptr: SUCCESS (0.000s)
[37.504959] [008/171] (957s left) fbdev (read)
[37.643611] Starting subtest: read
[37.776527] Subtest read: SUCCESS (0.146s)
[37.847331] [009/171] (957s left) fbdev (write)
[37.963723] Starting subtest: write
[38.036037] Subtest write: SUCCESS (0.069s)
[38.118969] [010/171] (957s left) gem_basic (bad-close)
[38.245610] Starting subtest: bad-close
[38.288713] Subtest bad-close: SUCCESS (0.000s)
[38.367079] [011/171] (957s left) gem_basic (create-close)
[38.519568] Starting subtest: create-close
[38.562665] Subtest create-close: SUCCESS (0.000s)
[38.646709] [012/171] (956s left) gem_basic (create-fd-close)
[38.791318] Starting subtest: create-fd-close
[38.835679] Subtest create-fd-close: SUCCESS (0.000s)
[38.921434] [013/171] (956s left) gem_busy (busy@all-engines)
[39.075850] Starting subtest: busy
[39.098784] Starting dynamic subtest: all-engines
[39.121419] Dynamic subtest all-engines: SUCCESS (0.020s)
[39.145763] Subtest busy: SUCCESS (0.020s)
[39.433048] [014/171] (956s left) gem_close_race (basic-process)
[39.584182] Starting subtest: basic-process
[39.631467] Subtest basic-process: SUCCESS (0.032s)
[39.820771] [015/171] (955s left) gem_close_race (basic-threads)
[39.972912] Starting subtest: basic-threads
[41.158914] Subtest basic-threads: SUCCESS (1.188s)
[41.339071] [016/171] (954s left) gem_ctx_create (basic)
[41.498684] Starting subtest: basic
[41.521712] Subtest basic: SUCCESS (0.000s)
[41.710968] [017/171] (954s left) gem_ctx_create (basic-files)
[41.846905] Starting subtest: basic-files
[43.894963] Subtest basic-files: SUCCESS (2.055s)
[44.140620] [018/171] (951s left) gem_ctx_exec (basic)
[44.294987] Starting subtest: basic
[44.315024] Subtest basic: SUCCESS (0.002s)
[44.388800] [019/171] (951s left) gem_exec_basic (basic)
[44.537400] Starting subtest: basic
[44.557101] Starting dynamic subtest: rcs0-smem
[44.581587] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[44.607296] Starting dynamic subtest: bcs0-smem
[44.629909] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[44.657518] Starting dynamic subtest: vcs0-smem
[44.678909] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[44.698353] Subtest basic: SUCCESS (0.002s)
[44.769599] [020/171] (951s left) gem_exec_create (basic)
[44.920588] Starting subtest: basic
[44.938997] Starting dynamic subtest: smem
[46.951913] Dynamic subtest smem: SUCCESS (2.038s)
[46.974602] Subtest basic: SUCCESS (2.038s)
[47.130657] [021/171] (949s left) gem_exec_fence (basic-busy)
[47.380395] Starting subtest: basic-busy
[47.399591] Starting dynamic subtest: rcs0
[47.443879] Dynamic subtest rcs0: SUCCESS (0.036s)
[47.470479] Starting dynamic subtest: bcs0
[47.511726] Dynamic subtest bcs0: SUCCESS (0.022s)
[47.536205] Starting dynamic subtest: vcs0
[47.577062] Dynamic subtest vcs0: SUCCESS (0.020s)
[47.599533] Subtest basic-busy: SUCCESS (0.078s)
[47.988042] [022/171] (948s left) gem_exec_fence (basic-wait)
[48.230827] Starting subtest: basic-wait
[48.252864] Starting dynamic subtest: rcs0
[48.272486] Dynamic subtest rcs0: SUCCESS (0.029s)
[48.297401] Starting dynamic subtest: bcs0
[48.316962] Dynamic subtest bcs0: SUCCESS (0.022s)
[48.340210] Starting dynamic subtest: vcs0
[48.362461] Dynamic subtest vcs0: SUCCESS (0.023s)
[48.384583] Subtest basic-wait: SUCCESS (0.075s)
[48.757800] [023/171] (947s left) gem_exec_fence (basic-await)
[49.001798] Starting subtest: basic-await
[49.023334] Starting dynamic subtest: rcs0
[49.063512] Dynamic subtest rcs0: SUCCESS (0.063s)
[49.086758] Starting dynamic subtest: bcs0
[49.125022] Dynamic subtest bcs0: SUCCESS (0.062s)
[49.215799] Starting dynamic subtest: vcs0
[49.237256] Dynamic subtest vcs0: SUCCESS (0.102s)
[49.257837] Subtest basic-await: SUCCESS (0.228s)
[49.672809] [024/171] (946s left) gem_exec_fence (nb-await)
[49.896251] Starting subtest: nb-await
[49.915777] Starting dynamic subtest: rcs0
[49.954336] Dynamic subtest rcs0: SUCCESS (0.053s)
[49.977754] Starting dynamic subtest: bcs0
[50.029798] Dynamic subtest bcs0: SUCCESS (0.053s)
[50.054500] Starting dynamic subtest: vcs0
[50.075841] Dynamic subtest vcs0: SUCCESS (0.053s)
[50.094762] Subtest nb-await: SUCCESS (0.159s)
[50.512454] [025/171] (945s left) gem_exec_gttfill (basic)
[50.661084] Starting subtest: basic
[53.050175] Subtest basic: SUCCESS (2.402s)
[53.238825] [026/171] (943s left) gem_exec_parallel (engines)
[53.471290] Starting subtest: engines
[53.489871] Starting dynamic subtest: basic
[54.898064] Dynamic subtest basic: SUCCESS (1.428s)
[54.923749] Starting dynamic subtest: contexts
[56.465818] Dynamic subtest contexts: SUCCESS (1.575s)
[56.489445] Starting dynamic subtest: fds
[58.231859] Dynamic subtest fds: SUCCESS (1.766s)
[58.255659] Starting dynamic subtest: userptr
[59.718787] Dynamic subtest userptr: SUCCESS (1.478s)
[59.740765] Subtest engines: SUCCESS (6.247s)
[59.907086] [027/171] (936s left) gem_exec_store (basic)
[60.117745] Starting subtest: basic
[60.139669] Subtest basic: SUCCESS (0.035s)
[60.271472] [028/171] (936s left) gem_flink_basic (bad-flink)
[60.414327] Starting subtest: bad-flink
[60.435836] Subtest bad-flink: SUCCESS (0.000s)
[60.508481] [029/171] (936s left) gem_flink_basic (bad-open)
[60.657409] Starting subtest: bad-open
[60.677323] Subtest bad-open: SUCCESS (0.000s)
[60.749634] [030/171] (935s left) gem_flink_basic (basic)
[60.893065] Starting subtest: basic
[60.912553] Subtest basic: SUCCESS (0.000s)
[61.007192] [031/171] (935s left) gem_flink_basic (double-flink)
[61.147410] Starting subtest: double-flink
[61.166737] Subtest double-flink: SUCCESS (0.000s)
[61.245517] [032/171] (935s left) gem_flink_basic (flink-lifetime)
[61.386222] Starting subtest: flink-lifetime
[61.407878] Subtest flink-lifetime: SUCCESS (0.001s)
[61.487406] [033/171] (935s left) gem_huc_copy (huc-copy)
[61.646736] Subtest huc-copy: SKIP (0.000s)
[61.723054] [034/171] (935s left) gem_linear_blits (basic)
[61.936767] Starting subtest: basic
[61.956664] Subtest basic: SUCCESS (0.005s)
[62.057834] [035/171] (935s left) gem_mmap (basic)
[62.293870] Starting subtest: basic
[62.404145] Subtest basic: SUCCESS (0.000s)
[62.483830] [036/171] (934s left) gem_mmap_gtt (basic)
[62.647621] Starting subtest: basic
[62.671557] Subtest basic: SUCCESS (0.001s)
[62.757318] [037/171] (934s left) gem_render_linear_blits (basic)
[62.910868] Starting subtest: basic
[63.023785] Subtest basic: SUCCESS (0.019s)
[63.118275] [038/171] (934s left) gem_render_tiled_blits (basic)
[63.251567] Starting subtest: basic
[63.395796] Subtest basic: SUCCESS (0.026s)
[63.478313] [039/171] (933s left) gem_ringfill (basic-all)
[63.735679] Starting subtest: basic-all
[64.814168] Subtest basic-all: SUCCESS (1.107s)
[64.935325] [040/171] (932s left) gem_softpin (allocator-basic)
[65.101829] Subtest allocator-basic: SKIP (0.000s)
[65.179892] [041/171] (932s left) gem_softpin (allocator-basic-reserve)
[65.336658] Subtest allocator-basic-reserve: SKIP (0.000s)
[65.416036] [042/171] (932s left) gem_softpin (safe-alignment)
[65.585812] Starting subtest: safe-alignment
[65.607381] Subtest safe-alignment: SUCCESS (0.005s)
[65.682596] [043/171] (931s left) gem_sync (basic-all)
[65.876533] Starting subtest: basic-all
[68.173533] Subtest basic-all: SUCCESS (2.147s)
[68.274075] [044/171] (929s left) gem_sync (basic-each)
[68.452174] Starting subtest: basic-each
[70.489596] Subtest basic-each: SUCCESS (2.075s)
[70.678760] [045/171] (927s left) gem_tiled_blits (basic)
[70.890503] Starting subtest: basic
[70.910156] Subtest basic: SUCCESS (0.013s)
[71.037913] [046/171] (926s left) gem_tiled_fence_blits (basic)
[71.328120] Starting subtest: basic
[71.349465] Subtest basic: SUCCESS (0.007s)
[71.471292] [047/171] (926s left) gem_tiled_pread_basic
[71.876837] [048/171] (926s left) gem_wait (busy@all-engines)
[72.004544] Starting subtest: busy
[72.023428] Starting dynamic subtest: all-engines
[72.523377] Dynamic subtest all-engines: SUCCESS (0.521s)
[72.545843] Subtest busy: SUCCESS (0.521s)
[72.737571] [049/171] (925s left) gem_wait (wait@all-engines)
[72.879522] Starting subtest: wait
[72.898707] Starting dynamic subtest: all-engines
[73.896463] Dynamic subtest all-engines: SUCCESS (1.013s)
[73.918708] Subtest wait: SUCCESS (1.013s)
[74.080816] [050/171] (923s left) i915_getparams_basic (basic-eu-total)
[74.222139] Starting subtest: basic-eu-total
[74.263714] Subtest basic-eu-total: SUCCESS (0.000s)
[74.336334] [051/171] (923s left) i915_getparams_basic (basic-subslice-total)
[74.480290] Starting subtest: basic-subslice-total
[74.518926] Subtest basic-subslice-total: SUCCESS (0.000s)
[74.595728] [052/171] (923s left) i915_hangman (error-state-basic)
[74.743481] Starting subtest: error-state-basic
[74.762804] Subtest error-state-basic: SUCCESS (0.005s)
[74.861457] [053/171] (923s left) i915_pciid
[75.097854] [054/171] (923s left) kms_addfb_basic (addfb25-bad-modifier)
[75.245667] Starting subtest: addfb25-bad-modifier
[75.267303] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[75.417060] [055/171] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[75.563761] Starting subtest: addfb25-framebuffer-vs-set-tiling
[75.582603] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[75.680576] [056/171] (922s left) kms_addfb_basic (addfb25-modifier-no-flag)
[75.815096] Starting subtest: addfb25-modifier-no-flag
[75.835142] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[75.935575] [057/171] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[76.074718] Starting subtest: addfb25-x-tiled-legacy
[76.095505] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[76.172667] [058/171] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[76.312617] Starting subtest: addfb25-x-tiled-mismatch-legacy
[76.333488] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[76.408803] [059/171] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[76.549086] Starting subtest: addfb25-yf-tiled-legacy
[76.569063] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[76.643784] [060/171] (921s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[76.811090] Starting subtest: addfb25-y-tiled-legacy
[76.830153] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[76.907286] [061/171] (921s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[77.045066] Starting subtest: addfb25-y-tiled-small-legacy
[77.084364] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[77.164623] [062/171] (921s left) kms_addfb_basic (bad-pitch-0)
[77.306018] Starting subtest: bad-pitch-0
[77.328133] Subtest bad-pitch-0: SUCCESS (0.000s)
[77.424197] [063/171] (921s left) kms_addfb_basic (bad-pitch-1024)
[77.566478] Starting subtest: bad-pitch-1024
[77.587193] Subtest bad-pitch-1024: SUCCESS (0.000s)
[77.662148] [064/171] (921s left) kms_addfb_basic (bad-pitch-128)
[77.809203] Starting subtest: bad-pitch-128
[77.829055] Subtest bad-pitch-128: SUCCESS (0.000s)
[77.903185] [065/171] (921s left) kms_addfb_basic (bad-pitch-256)
[78.025896] Starting subtest: bad-pitch-256
[78.045792] Subtest bad-pitch-256: SUCCESS (0.000s)
[78.125213] [066/171] (920s left) kms_addfb_basic (bad-pitch-32)
[78.267157] Starting subtest: bad-pitch-32
[78.286054] Subtest bad-pitch-32: SUCCESS (0.000s)
[78.361192] [067/171] (920s left) kms_addfb_basic (bad-pitch-63)
[78.501619] Starting subtest: bad-pitch-63
[78.520744] Subtest bad-pitch-63: SUCCESS (0.000s)
[78.598726] [068/171] (920s left) kms_addfb_basic (bad-pitch-65536)
[78.736328] Starting subtest: bad-pitch-65536
[78.755043] Subtest bad-pitch-65536: SUCCESS (0.000s)
[78.836955] [069/171] (920s left) kms_addfb_basic (bad-pitch-999)
[78.971222] Starting subtest: bad-pitch-999
[78.992545] Subtest bad-pitch-999: SUCCESS (0.000s)
[79.094956] [070/171] (920s left) kms_addfb_basic (basic)
[79.234474] Starting subtest: basic
[79.255878] Subtest basic: SUCCESS (0.000s)
[79.330733] [071/171] (919s left) kms_addfb_basic (basic-x-tiled-legacy)
[79.473679] Starting subtest: basic-x-tiled-legacy
[79.493876] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[79.567932] [072/171] (919s left) kms_addfb_basic (basic-y-tiled-legacy)
[79.709516] Starting subtest: basic-y-tiled-legacy
[79.728288] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[79.802395] [073/171] (919s left) kms_addfb_basic (bo-too-small)
[79.924986] Starting subtest: bo-too-small
[79.943952] Subtest bo-too-small: SUCCESS (0.000s)
[80.019361] [074/171] (919s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[80.158756] Starting subtest: bo-too-small-due-to-tiling
[80.177268] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[80.275663] [075/171] (919s left) kms_addfb_basic (clobberred-modifier)
[80.410917] Starting subtest: clobberred-modifier
[80.430822] Subtest clobberred-modifier: SUCCESS (0.000s)
[80.532212] [076/171] (919s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[80.669814] Starting subtest: framebuffer-vs-set-tiling
[80.691097] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[80.767861] [077/171] (918s left) kms_addfb_basic (invalid-get-prop)
[80.887756] Starting subtest: invalid-get-prop
[80.908743] Subtest invalid-get-prop: SUCCESS (0.000s)
[80.984518] [078/171] (918s left) kms_addfb_basic (invalid-get-prop-any)
[81.126129] Starting subtest: invalid-get-prop-any
[81.146606] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[81.221275] [079/171] (918s left) kms_addfb_basic (invalid-set-prop)
[81.363910] Starting subtest: invalid-set-prop
[81.384116] Subtest invalid-set-prop: SUCCESS (0.000s)
[81.478693] [080/171] (918s left) kms_addfb_basic (invalid-set-prop-any)
[81.616321] Starting subtest: invalid-set-prop-any
[81.634885] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[81.713055] [081/171] (918s left) kms_addfb_basic (no-handle)
[81.850407] Starting subtest: no-handle
[81.869128] Subtest no-handle: SUCCESS (0.000s)
[81.947610] [082/171] (917s left) kms_addfb_basic (size-max)
[82.081395] Starting subtest: size-max
[82.101375] Subtest size-max: SUCCESS (0.000s)
[82.181363] [083/171] (917s left) kms_addfb_basic (small-bo)
[82.317422] Starting subtest: small-bo
[82.338846] Subtest small-bo: SUCCESS (0.000s)
[82.437599] [084/171] (917s left) kms_addfb_basic (tile-pitch-mismatch)
[82.573080] Starting subtest: tile-pitch-mismatch
[82.591886] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[82.709852] [085/171] (917s left) kms_addfb_basic (too-high)
[82.866709] Starting subtest: too-high
[82.888317] Subtest too-high: SUCCESS (0.001s)
[82.988426] [086/171] (917s left) kms_addfb_basic (too-wide)
[83.146713] Starting subtest: too-wide
[83.173721] Subtest too-wide: SUCCESS (0.000s)
[83.270982] [087/171] (917s left) kms_addfb_basic (unused-handle)
[83.427646] Starting subtest: unused-handle
[83.451763] Subtest unused-handle: SUCCESS (0.000s)
[83.548220] [088/171] (916s left) kms_addfb_basic (unused-modifier)
[83.705185] Starting subtest: unused-modifier
[83.731350] Subtest unused-modifier: SUCCESS (0.000s)
[83.828472] [089/171] (916s left) kms_addfb_basic (unused-offsets)
[83.985024] Starting subtest: unused-offsets
[84.009114] Subtest unused-offsets: SUCCESS (0.000s)
[84.104055] [090/171] (916s left) kms_addfb_basic (unused-pitches)
[84.271825] Starting subtest: unused-pitches
[84.299575] Subtest unused-pitches: SUCCESS (0.000s)
[84.393339] [091/171] (916s left) kms_busy (basic)
[84.544975] Starting subtest: basic
[84.626271] Starting dynamic subtest: flip
[85.298973] Dynamic subtest flip: SUCCESS (0.758s)
[85.323236] Starting dynamic subtest: modeset
[85.796290] Dynamic subtest modeset: SUCCESS (0.496s)
[85.816886] Subtest basic: SUCCESS (1.254s)
[85.968807] [092/171] (914s left) kms_chamelium_hpd (dp-hpd-fast)
[86.190543] Subtest dp-hpd-fast: SKIP (0.000s)
[86.304871] [093/171] (914s left) kms_chamelium_edid (dp-edid-read)
[86.512120] Subtest dp-edid-read: SKIP (0.000s)
[86.644805] [094/171] (914s left) kms_chamelium_frames (dp-crc-fast)
[86.854160] Subtest dp-crc-fast: SKIP (0.000s)
[86.965774] [095/171] (914s left) kms_chamelium_hpd (hdmi-hpd-fast)
[87.184714] Subtest hdmi-hpd-fast: SKIP (0.000s)
[87.297772] [096/171] (913s left) kms_chamelium_edid (hdmi-edid-read)
[87.500999] Subtest hdmi-edid-read: SKIP (0.000s)
[87.643204] [097/171] (913s left) kms_chamelium_frames (hdmi-crc-fast)
[87.841629] Subtest hdmi-crc-fast: SKIP (0.000s)
[87.985181] [098/171] (913s left) kms_chamelium_hpd (vga-hpd-fast)
[88.181949] Subtest vga-hpd-fast: SKIP (0.000s)
[88.296819] [099/171] (913s left) kms_chamelium_edid (vga-edid-read)
[88.493490] Subtest vga-edid-read: SKIP (0.000s)
[88.620189] [100/171] (912s left) kms_prop_blob (basic)
[88.767569] Starting subtest: basic
[88.788824] Subtest basic: SUCCESS (0.000s)
[88.862691] [101/171] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[89.011015] Starting subtest: basic-busy-flip-before-cursor-atomic
[89.940681] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.930s)
[90.104193] [102/171] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[90.244405] Starting subtest: basic-busy-flip-before-cursor-legacy
[91.177322] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.929s)
[91.341282] [103/171] (910s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[91.484985] Starting subtest: basic-flip-after-cursor-atomic
[92.415912] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.926s)
[92.577930] [104/171] (909s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[92.717299] Starting subtest: basic-flip-after-cursor-legacy
[93.652983] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.928s)
[93.815493] [105/171] (908s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[93.954771] Starting subtest: basic-flip-after-cursor-varying-size
[94.890483] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.925s)
[95.047108] [106/171] (906s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[95.187537] Starting subtest: basic-flip-before-cursor-atomic
[96.120670] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.926s)
[96.286706] [107/171] (905s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[96.425023] Starting subtest: basic-flip-before-cursor-legacy
[97.358992] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.926s)
[97.528047] [108/171] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[97.661575] Starting subtest: basic-flip-before-cursor-varying-size
[98.598213] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.930s)
[98.764370] [109/171] (903s left) kms_flip (basic-flip-vs-dpms)
[98.926208] Starting subtest: basic-flip-vs-dpms
[98.947895] Starting dynamic subtest: A-VGA1
[99.838622] Dynamic subtest A-VGA1: SUCCESS (0.934s)
[99.862680] Starting dynamic subtest: B-VGA1
[100.717880] Dynamic subtest B-VGA1: SUCCESS (0.880s)
[100.744770] Starting dynamic subtest: C-VGA1
[101.600172] Dynamic subtest C-VGA1: SUCCESS (0.878s)
[101.618865] Subtest basic-flip-vs-dpms: SUCCESS (2.695s)
[101.770552] [110/171] (900s left) kms_flip (basic-flip-vs-modeset)
[101.935264] Starting subtest: basic-flip-vs-modeset
[101.955505] Starting dynamic subtest: A-VGA1
[102.772253] Dynamic subtest A-VGA1: SUCCESS (0.850s)
[102.798354] Starting dynamic subtest: B-VGA1
[103.675048] Dynamic subtest B-VGA1: SUCCESS (0.902s)
[103.706461] Starting dynamic subtest: C-VGA1
[104.447836] Dynamic subtest C-VGA1: SUCCESS (0.785s)
[104.470161] Subtest basic-flip-vs-modeset: SUCCESS (2.540s)
[104.655223] [111/171] (897s left) kms_flip (basic-flip-vs-wf_vblank)
[104.843139] Starting subtest: basic-flip-vs-wf_vblank
[104.866040] Starting dynamic subtest: A-VGA1
[105.952481] Dynamic subtest A-VGA1: SUCCESS (1.141s)
[105.981602] Starting dynamic subtest: B-VGA1
[107.074309] Dynamic subtest B-VGA1: SUCCESS (1.123s)
[107.108037] Starting dynamic subtest: C-VGA1
[108.200508] Dynamic subtest C-VGA1: SUCCESS (1.124s)
[108.225939] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.392s)
[108.392704] [112/171] (893s left) kms_flip (basic-plain-flip)
[108.586974] Starting subtest: basic-plain-flip
[108.611583] Starting dynamic subtest: A-VGA1
[109.422928] Dynamic subtest A-VGA1: SUCCESS (0.860s)
[109.458178] Starting dynamic subtest: B-VGA1
[110.253564] Dynamic subtest B-VGA1: SUCCESS (0.839s)
[110.286215] Starting dynamic subtest: C-VGA1
[111.093654] Dynamic subtest C-VGA1: SUCCESS (0.839s)
[111.119034] Subtest basic-plain-flip: SUCCESS (2.541s)
[111.285938] [113/171] (891s left) kms_force_connector_basic (force-connector-state)
[111.447677] Starting subtest: force-connector-state
[111.592826] Subtest force-connector-state: SUCCESS (0.144s)
[111.830521] [114/171] (890s left) kms_force_connector_basic (force-edid)
[111.994877] Starting subtest: force-edid
[112.075020] Subtest force-edid: SUCCESS (0.082s)
[112.215704] [115/171] (890s left) kms_force_connector_basic (force-load-detect)
[112.360698] Starting subtest: force-load-detect
[112.521087] Subtest force-load-detect: SUCCESS (0.152s)
[112.704514] [116/171] (890s left) kms_force_connector_basic (prune-stale-modes)
[112.845828] Starting subtest: prune-stale-modes
[112.866755] Subtest prune-stale-modes: SUCCESS (0.015s)
[112.984556] [117/171] (889s left) kms_frontbuffer_tracking (basic)
[113.238337] Starting subtest: basic
[114.978819] Subtest basic: SUCCESS (1.817s)
[115.088865] [118/171] (887s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[115.238619] Starting subtest: compare-crc-sanitycheck
[115.260413] Starting dynamic subtest: pipe-A-VGA-1
[115.506459] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.263s)
[115.533576] Starting dynamic subtest: pipe-B-VGA-1
[115.786173] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.277s)
[115.811769] Starting dynamic subtest: pipe-C-VGA-1
[116.053891] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.271s)
[116.073860] Subtest compare-crc-sanitycheck: SUCCESS (0.814s)
[116.228434] [119/171] (886s left) kms_pipe_crc_basic (hang-read-crc)
[116.368217] Starting subtest: hang-read-crc
[116.390186] Starting dynamic subtest: pipe-A-VGA-1
[117.134231] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.758s)
[117.158611] Starting dynamic subtest: pipe-B-VGA-1
[117.902844] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.763s)
[117.928496] Starting dynamic subtest: pipe-C-VGA-1
[118.669321] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.771s)
[118.689937] Subtest hang-read-crc: SUCCESS (2.294s)
[118.831120] [120/171] (884s left) kms_pipe_crc_basic (nonblocking-crc)
[118.980103] Starting subtest: nonblocking-crc
[119.000391] Starting dynamic subtest: pipe-A-VGA-1
[119.440239] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.457s)
[119.467592] Starting dynamic subtest: pipe-B-VGA-1
[119.899823] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.447s)
[119.924507] Starting dynamic subtest: pipe-C-VGA-1
[120.342972] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.452s)
[120.362138] Subtest nonblocking-crc: SUCCESS (1.358s)
[120.504952] [121/171] (882s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[120.652162] Starting subtest: nonblocking-crc-frame-sequence
[120.673349] Starting dynamic subtest: pipe-A-VGA-1
[121.100288] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.442s)
[121.124936] Starting dynamic subtest: pipe-B-VGA-1
[121.547787] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.448s)
[121.582725] Starting dynamic subtest: pipe-C-VGA-1
[122.006598] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.451s)
[122.025692] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.343s)
[122.172688] [122/171] (881s left) kms_pipe_crc_basic (read-crc)
[122.312466] Starting subtest: read-crc
[122.335215] Starting dynamic subtest: pipe-A-VGA-1
[122.709407] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.384s)
[122.735905] Starting dynamic subtest: pipe-B-VGA-1
[123.092026] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.379s)
[123.116646] Starting dynamic subtest: pipe-C-VGA-1
[123.469578] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.384s)
[123.491341] Subtest read-crc: SUCCESS (1.150s)
[123.632496] [123/171] (879s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[123.776559] Starting subtest: read-crc-frame-sequence
[123.810367] Starting dynamic subtest: pipe-A-VGA-1
[124.166832] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.379s)
[124.196253] Starting dynamic subtest: pipe-B-VGA-1
[124.556790] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.382s)
[124.585099] Starting dynamic subtest: pipe-C-VGA-1
[124.946245] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.386s)
[124.967542] Subtest read-crc-frame-sequence: SUCCESS (1.149s)
[125.099404] [124/171] (878s left) kms_psr (primary_page_flip)
[125.285228] Subtest primary_page_flip: SKIP (0.000s)
[125.375143] [125/171] (878s left) kms_psr (cursor_plane_move)
[125.548420] Subtest cursor_plane_move: SKIP (0.000s)
[125.634309] [126/171] (878s left) kms_psr (sprite_plane_onoff)
[125.815717] Subtest sprite_plane_onoff: SKIP (0.000s)
[125.898395] [127/171] (877s left) kms_psr (primary_mmap_gtt)
[126.077254] Subtest primary_mmap_gtt: SKIP (0.000s)
[126.159907] [128/171] (877s left) kms_setmode (basic-clone-single-crtc)
[126.303916] Starting subtest: basic-clone-single-crtc
[126.371559] Subtest basic-clone-single-crtc: SKIP (0.000s)
[126.457077] [129/171] (877s left) i915_pm_backlight (basic-brightness)
[126.611403] Subtest basic-brightness: SKIP (0.000s)
[126.700314] [130/171] (877s left) i915_pm_rpm (basic-pci-d3-state)
[138.205834] Subtest basic-pci-d3-state: SKIP (0.000s)
[138.282282] [131/171] (865s left) i915_pm_rpm (basic-rte)
[138.421239] Starting subtest: basic-rte
[149.748106] Subtest basic-rte: SKIP (11.100s)
[149.867835] [132/171] (854s left) i915_pm_rps (basic-api)
[149.998157] Starting subtest: basic-api
[150.019618] Subtest basic-api: SUCCESS (0.002s)
[150.096346] [133/171] (854s left) prime_self_import (basic-llseek-bad)
[150.247325] Starting subtest: basic-llseek-bad
[150.268885] Subtest basic-llseek-bad: SUCCESS (0.001s)
[150.343654] [134/171] (854s left) prime_self_import (basic-llseek-size)
[150.491277] Starting subtest: basic-llseek-size
[150.510897] Subtest basic-llseek-size: SUCCESS (0.002s)
[150.585845] [135/171] (853s left) prime_self_import (basic-with_fd_dup)
[150.727498] Starting subtest: basic-with_fd_dup
[150.746961] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[150.824135] [136/171] (853s left) prime_self_import (basic-with_one_bo)
[150.963099] Starting subtest: basic-with_one_bo
[150.982434] Subtest basic-with_one_bo: SUCCESS (0.002s)
[151.062465] [137/171] (853s left) prime_self_import (basic-with_one_bo_two_files)
[151.199053] Starting subtest: basic-with_one_bo_two_files
[151.218487] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[151.300222] [138/171] (853s left) prime_self_import (basic-with_two_bos)
[151.435438] Starting subtest: basic-with_two_bos
[151.457565] Subtest basic-with_two_bos: SUCCESS (0.002s)
[151.538486] [139/171] (853s left) prime_vgem (basic-fence-flip)
[151.681572] Starting subtest: basic-fence-flip
[151.992915] Subtest basic-fence-flip: SUCCESS (0.313s)
[152.109286] [140/171] (852s left) prime_vgem (basic-fence-mmap)
[152.248529] Starting subtest: basic-fence-mmap
[152.267766] Subtest basic-fence-mmap: SUCCESS (0.028s)
[152.368961] [141/171] (852s left) prime_vgem (basic-fence-read)
[152.525690] Starting subtest: basic-fence-read
[152.547507] Subtest basic-fence-read: SUCCESS (0.036s)
[152.646405] [142/171] (852s left) prime_vgem (basic-gtt)
[152.788812] Starting subtest: basic-gtt
[152.809259] Subtest basic-gtt: SUCCESS (0.011s)
[152.904191] [143/171] (852s left) prime_vgem (basic-read)
[153.045774] Starting subtest: basic-read
[153.065311] Subtest basic-read: SUCCESS (0.016s)
[153.165325] [144/171] (851s left) prime_vgem (basic-write)
[153.300853] Starting subtest: basic-write
[153.321450] Subtest basic-write: SUCCESS (0.018s)
[153.423130] [145/171] (851s left) prime_vgem (basic-userptr)
[153.584624] Starting subtest: basic-userptr
[153.626318] Subtest basic-userptr: SKIP (0.012s)
[153.720628] [146/171] (851s left) vgem_basic (setversion)
[153.870802] Starting subtest: setversion
[153.909471] Subtest setversion: SUCCESS (0.000s)
[153.990752] [147/171] (851s left) vgem_basic (create)
[154.111667] Starting subtest: create
[154.131090] Subtest create: SUCCESS (0.000s)
[154.211315] [148/171] (851s left) vgem_basic (debugfs)
[154.344896] Starting subtest: debugfs
[154.365771] Subtest debugfs: SUCCESS (0.001s)
[154.446989] [149/171] (850s left) vgem_basic (dmabuf-export)
[154.582084] Starting subtest: dmabuf-export
[154.604342] Subtest dmabuf-export: SUCCESS (0.002s)
[154.710987] [150/171] (850s left) vgem_basic (dmabuf-fence)
[154.851575] Starting subtest: dmabuf-fence
[154.872875] Subtest dmabuf-fence: SUCCESS (0.000s)
[154.948223] [151/171] (850s left) vgem_basic (dmabuf-fence-before)
[155.091536] Starting subtest: dmabuf-fence-before
[155.111806] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[155.186470] [152/171] (850s left) vgem_basic (dmabuf-mmap)
[155.330257] Starting subtest: dmabuf-mmap
[155.349674] Subtest dmabuf-mmap: SUCCESS (0.015s)
[155.424986] [153/171] (850s left) vgem_basic (mmap)
[155.565965] Starting subtest: mmap
[155.585341] Subtest mmap: SUCCESS (0.010s)
[155.662816] [154/171] (850s left) vgem_basic (second-client)
[155.801461] Starting subtest: second-client
[155.864682] Subtest second-client: SUCCESS (0.049s)
[155.944538] [155/171] (849s left) vgem_basic (sysfs)
[156.073719] Starting subtest: sysfs
[156.095789] Subtest sysfs: SUCCESS (0.001s)
[156.174142] [156/171] (849s left) core_hotunplug (unbind-rebind)
[156.371089] Starting subtest: unbind-rebind
[157.074693] Subtest unbind-rebind: SUCCESS (0.702s)
[157.171232] [157/171] (848s left) vgem_basic (unload)
[157.312921] Starting subtest: unload
[186.234324] Subtest unload: SUCCESS (28.743s)
[186.310775] [158/171] (819s left) i915_module_load (reload)
[186.458394] Starting subtest: reload
[188.227185] Subtest reload: SUCCESS (1.779s)
[188.322205] [159/171] (817s left) gem_lmem_swapping (basic)
[188.491836] Subtest basic: SKIP (0.000s)
[188.572337] [160/171] (817s left) gem_lmem_swapping (parallel-random-engines)
[188.731031] Subtest parallel-random-engines: SKIP (0.000s)
[188.809790] [161/171] (817s left) gem_lmem_swapping (random-engines)
[188.957425] Subtest random-engines: SKIP (0.000s)
[189.037913] [162/171] (817s left) gem_lmem_swapping (verify-random)
[189.206799] Subtest verify-random: SKIP (0.000s)
[189.282673] [163/171] (817s left) i915_pm_rpm (module-reload)
[200.819822] Subtest module-reload: SKIP (0.000s)
[200.895383] [164/171] (805s left) i915_selftest (live)
[201.601426] Starting subtest: live
[201.620779] Starting dynamic subtest: sanitycheck
[202.117740] Dynamic subtest sanitycheck: SUCCESS (0.509s)
[202.145956] Starting dynamic subtest: uncore
[202.643749] Dynamic subtest uncore: SUCCESS (0.531s)
[202.679430] Starting dynamic subtest: workarounds
[203.256838] Dynamic subtest workarounds: SUCCESS (0.611s)
[203.284865] Starting dynamic subtest: gt_engines
[203.818550] Dynamic subtest gt_engines: SUCCESS (0.556s)
[203.848511] Starting dynamic subtest: gt_timelines
[208.828473] Dynamic subtest gt_timelines: SUCCESS (5.017s)
[208.853483] Starting dynamic subtest: gt_contexts
[209.408390] Dynamic subtest gt_contexts: SUCCESS (0.577s)
[209.435057] Starting dynamic subtest: gt_lrc
[209.976478] Dynamic subtest gt_lrc: SUCCESS (0.569s)
[210.001366] Starting dynamic subtest: gt_mocs
[210.505331] Dynamic subtest gt_mocs: SUCCESS (0.526s)
[210.531898] Starting dynamic subtest: gt_pm
[218.610152] Dynamic subtest gt_pm: SUCCESS (8.107s)
[218.636328] Starting dynamic subtest: gt_heartbeat
[219.239158] Dynamic subtest gt_heartbeat: SUCCESS (0.628s)
[219.264315] Starting dynamic subtest: requests
[224.458705] Dynamic subtest requests: SUCCESS (5.219s)
[224.483297] Starting dynamic subtest: migrate
[224.991380] Dynamic subtest migrate: SUCCESS (0.529s)
[225.018437] Starting dynamic subtest: active
[225.505389] Dynamic subtest active: SUCCESS (0.516s)
[225.530190] Starting dynamic subtest: objects
[226.435592] Dynamic subtest objects: SUCCESS (0.928s)
[226.461034] Starting dynamic subtest: mman
[230.359393] Dynamic subtest mman: SUCCESS (3.925s)
[230.384338] Starting dynamic subtest: dmabuf
[230.933185] Dynamic subtest dmabuf: SUCCESS (0.571s)
[230.958157] Starting dynamic subtest: vma
[231.467438] Dynamic subtest vma: SUCCESS (0.536s)
[231.494995] Starting dynamic subtest: coherency
[233.012326] Dynamic subtest coherency: SUCCESS (1.544s)
[233.039660] Starting dynamic subtest: gtt
[236.732467] Dynamic subtest gtt: SUCCESS (3.719s)
[236.763377] Starting dynamic subtest: gem
[237.318803] Dynamic subtest gem: SUCCESS (0.584s)
[237.347843] Starting dynamic subtest: evict
[237.812503] Dynamic subtest evict: SUCCESS (0.495s)
[237.839609] Starting dynamic subtest: hugepages
[239.467204] Dynamic subtest hugepages: SUCCESS (1.651s)
[239.494020] Starting dynamic subtest: gem_contexts
[243.654849] Dynamic subtest gem_contexts: SUCCESS (4.187s)
[243.682181] Starting dynamic subtest: client
[244.229423] Dynamic subtest client: SUCCESS (0.577s)
[244.254822] Starting dynamic subtest: gem_migrate
[244.760546] Dynamic subtest gem_migrate: SUCCESS (0.527s)
[244.787808] Starting dynamic subtest: reset
[245.311351] Dynamic subtest reset: SUCCESS (0.553s)
[245.336628] Starting dynamic subtest: memory_region
[245.873074] Dynamic subtest memory_region: SUCCESS (0.559s)
[245.900530] Starting dynamic subtest: hangcheck
[259.078396] Dynamic subtest hangcheck: SUCCESS (13.208s)
[259.105859] Starting dynamic subtest: execlists
[259.583799] Dynamic subtest execlists: SUCCESS (0.503s)
[259.608878] Starting dynamic subtest: ring_submission
[260.110898] Dynamic subtest ring_submission: SUCCESS (0.528s)
[260.138828] Starting dynamic subtest: perf
[260.628375] Dynamic subtest perf: SUCCESS (0.514s)
[260.653557] Starting dynamic subtest: slpc
[261.175363] Dynamic subtest slpc: SUCCESS (0.549s)
[261.200740] Starting dynamic subtest: guc
[261.724337] Dynamic subtest guc: SUCCESS (0.544s)
[261.754333] Starting dynamic subtest: guc_multi_lrc
[262.235877] Dynamic subtest guc_multi_lrc: SUCCESS (0.511s)
[262.268844] Starting dynamic subtest: guc_hang
[262.781413] Dynamic subtest guc_hang: SUCCESS (0.543s)
[262.811482] Starting dynamic subtest: late_gt_pm
[263.349426] Dynamic subtest late_gt_pm: SUCCESS (0.569s)
[263.371969] Subtest live: SUCCESS (61.743s)
[263.515616] [165/171] (743s left) dmabuf (all-tests)
[263.671952] Starting subtest: all-tests
[263.696717] Starting dynamic subtest: sanitycheck
[263.720802] Dynamic subtest sanitycheck: SUCCESS (0.034s)
[263.749395] Starting dynamic subtest: dma_fence
[263.838867] Dynamic subtest dma_fence: SUCCESS (0.136s)
[263.865064] Starting dynamic subtest: dma_fence_chain
[275.999358] Dynamic subtest dma_fence_chain: SUCCESS (12.076s)
[276.027298] Starting dynamic subtest: dma_fence_unwrap
[276.049561] Dynamic subtest dma_fence_unwrap: SUCCESS (0.026s)
[276.076297] Starting dynamic subtest: dma_resv
[276.097808] Dynamic subtest dma_resv: SUCCESS (0.029s)
[276.117401] Subtest all-tests: SUCCESS (12.302s)
[276.192121] [166/171] (730s left) i915_suspend (basic-s2idle-without-i915)
[276.345524] Starting subtest: basic-s2idle-without-i915
[294.286079] Subtest basic-s2idle-without-i915: SUCCESS (2.241s)
[297.169142] [167/171] (728s left) i915_suspend (basic-s3-without-i915)
[297.295961] Starting subtest: basic-s3-without-i915
[315.184003] Subtest basic-s3-without-i915: SUCCESS (1.932s)
[318.169998] [168/171] (726s left) gem_exec_suspend (basic-s0)
[318.329064] Starting subtest: basic-S0
[318.347523] Starting dynamic subtest: smem
[335.118715] Dynamic subtest smem: SUCCESS (1.797s)
[335.137465] Subtest basic-S0: SUCCESS (1.798s)
[338.006596] [169/171] (724s left) gem_exec_suspend (basic-s3)
[338.143557] Starting subtest: basic-S3
[338.164830] Starting dynamic subtest: smem
[355.983576] Dynamic subtest smem: SUCCESS (1.707s)
[356.002322] Subtest basic-S3: SUCCESS (1.707s)
[359.174225] [170/171] (722s left) kms_chamelium_hpd (common-hpd-after-suspend)
[359.407022] Subtest common-hpd-after-suspend: SKIP (0.000s)
[359.522224] [171/171] (721s left) kms_pipe_crc_basic (suspend-read-crc)
[359.661461] Starting subtest: suspend-read-crc
[359.680276] Starting dynamic subtest: pipe-A-VGA-1
[378.128398] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.806s)
[378.155906] Starting dynamic subtest: pipe-B-VGA-1
[396.140978] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.821s)
[396.167899] Starting dynamic subtest: pipe-C-VGA-1
[414.138190] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.817s)
[414.156509] Subtest suspend-read-crc: SUCCESS (5.446s)
[417.286138] Closing watchdogs
Done.