[34.532051] Initializing watchdogs
[34.532253]   /dev/watchdog0
[34.558622] [001/171] (960s left) i915_module_load (load)
[34.713963] Starting subtest: load
[36.123660] Subtest load: SUCCESS (1.402s)
[36.264224] [002/171] (958s left) core_auth (basic-auth)
[36.442507] Starting subtest: basic-auth
[36.461672] Subtest basic-auth: SUCCESS (0.000s)
[36.538727] [003/171] (958s left) debugfs_test (read_all_entries)
[36.672387] Starting subtest: read_all_entries
[36.711271] Subtest read_all_entries: SUCCESS (0.042s)
[36.810716] [004/171] (958s left) debugfs_test (basic-hwmon)
[36.948181] Starting subtest: basic-hwmon
[36.990615] Subtest basic-hwmon: SKIP (0.000s)
[37.064436] [005/171] (958s left) fbdev (eof)
[37.214457] Starting subtest: eof
[37.236125] Subtest eof: SUCCESS (0.000s)
[37.306929] [006/171] (958s left) fbdev (info)
[37.452489] Starting subtest: info
[37.471767] Subtest info: SUCCESS (0.000s)
[37.541574] [007/171] (957s left) fbdev (nullptr)
[37.683483] Starting subtest: nullptr
[37.702665] Subtest nullptr: SUCCESS (0.000s)
[37.774977] [008/171] (957s left) fbdev (read)
[37.902144] Starting subtest: read
[38.018341] Subtest read: SUCCESS (0.129s)
[38.094448] [009/171] (957s left) fbdev (write)
[38.229125] Starting subtest: write
[38.289160] Subtest write: SUCCESS (0.064s)
[38.365924] [010/171] (957s left) gem_basic (bad-close)
[38.504094] Starting subtest: bad-close
[38.547436] Subtest bad-close: SUCCESS (0.000s)
[38.619531] [011/171] (957s left) gem_basic (create-close)
[38.762194] Starting subtest: create-close
[38.802449] Subtest create-close: SUCCESS (0.000s)
[38.872388] [012/171] (956s left) gem_basic (create-fd-close)
[39.014443] Starting subtest: create-fd-close
[39.052697] Subtest create-fd-close: SUCCESS (0.000s)
[39.128403] [013/171] (956s left) gem_busy (busy@all-engines)
[39.256457] Starting subtest: busy
[39.275655] Starting dynamic subtest: all-engines
[39.294715] Dynamic subtest all-engines: SUCCESS (0.018s)
[39.316566] Subtest busy: SUCCESS (0.018s)
[39.598276] [014/171] (956s left) gem_close_race (basic-process)
[39.753108] Starting subtest: basic-process
[39.775068] Subtest basic-process: SUCCESS (0.037s)
[39.986578] [015/171] (955s left) gem_close_race (basic-threads)
[40.112862] Starting subtest: basic-threads
[41.299506] Subtest basic-threads: SUCCESS (1.186s)
[41.477269] [016/171] (954s left) gem_ctx_create (basic)
[41.642290] Starting subtest: basic
[41.664696] Subtest basic: SUCCESS (0.000s)
[41.821069] [017/171] (954s left) gem_ctx_create (basic-files)
[41.965995] Starting subtest: basic-files
[43.988764] Subtest basic-files: SUCCESS (2.011s)
[44.236893] [018/171] (951s left) gem_ctx_exec (basic)
[44.388380] Starting subtest: basic
[44.409799] Subtest basic: SUCCESS (0.002s)
[44.482998] [019/171] (951s left) gem_exec_basic (basic)
[44.633626] Starting subtest: basic
[44.655135] Starting dynamic subtest: rcs0-smem
[44.675129] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[44.698381] Starting dynamic subtest: bcs0-smem
[44.717331] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[44.742193] Starting dynamic subtest: vcs0-smem
[44.762728] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[44.784495] Subtest basic: SUCCESS (0.001s)
[44.861279] [020/171] (951s left) gem_exec_create (basic)
[45.006947] Starting subtest: basic
[45.027466] Starting dynamic subtest: smem
[47.034633] Dynamic subtest smem: SUCCESS (2.036s)
[47.053939] Subtest basic: SUCCESS (2.037s)
[47.237936] [021/171] (949s left) gem_exec_fence (basic-busy)
[47.481995] Starting subtest: basic-busy
[47.501164] Starting dynamic subtest: rcs0
[47.539497] Dynamic subtest rcs0: SUCCESS (0.029s)
[47.565413] Starting dynamic subtest: bcs0
[47.608857] Dynamic subtest bcs0: SUCCESS (0.024s)
[47.634169] Starting dynamic subtest: vcs0
[47.673387] Dynamic subtest vcs0: SUCCESS (0.032s)
[47.693585] Subtest basic-busy: SUCCESS (0.085s)
[48.094738] [022/171] (948s left) gem_exec_fence (basic-wait)
[48.336643] Starting subtest: basic-wait
[48.358176] Starting dynamic subtest: rcs0
[48.379861] Dynamic subtest rcs0: SUCCESS (0.029s)
[48.404124] Starting dynamic subtest: bcs0
[48.423541] Dynamic subtest bcs0: SUCCESS (0.036s)
[48.447922] Starting dynamic subtest: vcs0
[48.467180] Dynamic subtest vcs0: SUCCESS (0.022s)
[48.487708] Subtest basic-wait: SUCCESS (0.087s)
[48.864478] [023/171] (947s left) gem_exec_fence (basic-await)
[49.107581] Starting subtest: basic-await
[49.128922] Starting dynamic subtest: rcs0
[49.168902] Dynamic subtest rcs0: SUCCESS (0.063s)
[49.191797] Starting dynamic subtest: bcs0
[49.240052] Dynamic subtest bcs0: SUCCESS (0.062s)
[49.290161] Starting dynamic subtest: vcs0
[49.317733] Dynamic subtest vcs0: SUCCESS (0.068s)
[49.338038] Subtest basic-await: SUCCESS (0.194s)
[49.748330] [024/171] (946s left) gem_exec_fence (nb-await)
[49.988875] Starting subtest: nb-await
[50.007877] Starting dynamic subtest: rcs0
[50.045060] Dynamic subtest rcs0: SUCCESS (0.053s)
[50.070602] Starting dynamic subtest: bcs0
[50.111687] Dynamic subtest bcs0: SUCCESS (0.052s)
[50.136432] Starting dynamic subtest: vcs0
[50.155041] Dynamic subtest vcs0: SUCCESS (0.052s)
[50.173593] Subtest nb-await: SUCCESS (0.157s)
[50.598761] [025/171] (946s left) gem_exec_gttfill (basic)
[50.728196] Starting subtest: basic
[53.178435] Subtest basic: SUCCESS (2.463s)
[53.383733] [026/171] (943s left) gem_exec_parallel (engines)
[53.609058] Starting subtest: engines
[53.630190] Starting dynamic subtest: basic
[55.025063] Dynamic subtest basic: SUCCESS (1.421s)
[55.049094] Starting dynamic subtest: contexts
[56.579439] Dynamic subtest contexts: SUCCESS (1.558s)
[56.607380] Starting dynamic subtest: fds
[58.350476] Dynamic subtest fds: SUCCESS (1.771s)
[58.374250] Starting dynamic subtest: userptr
[59.825343] Dynamic subtest userptr: SUCCESS (1.462s)
[59.846746] Subtest engines: SUCCESS (6.213s)
[60.012530] [027/171] (936s left) gem_exec_store (basic)
[60.220502] Starting subtest: basic
[60.242478] Subtest basic: SUCCESS (0.037s)
[60.384493] [028/171] (936s left) gem_flink_basic (bad-flink)
[60.524848] Starting subtest: bad-flink
[60.544361] Subtest bad-flink: SUCCESS (0.000s)
[60.630950] [029/171] (936s left) gem_flink_basic (bad-open)
[60.767239] Starting subtest: bad-open
[60.786355] Subtest bad-open: SUCCESS (0.000s)
[60.865619] [030/171] (936s left) gem_flink_basic (basic)
[61.000155] Starting subtest: basic
[61.022185] Subtest basic: SUCCESS (0.000s)
[61.101679] [031/171] (935s left) gem_flink_basic (double-flink)
[61.241645] Starting subtest: double-flink
[61.263071] Subtest double-flink: SUCCESS (0.000s)
[61.338228] [032/171] (935s left) gem_flink_basic (flink-lifetime)
[61.479959] Starting subtest: flink-lifetime
[61.501119] Subtest flink-lifetime: SUCCESS (0.001s)
[61.575036] [033/171] (935s left) gem_huc_copy (huc-copy)
[61.738041] Subtest huc-copy: SKIP (0.000s)
[61.809736] [034/171] (935s left) gem_linear_blits (basic)
[62.032757] Starting subtest: basic
[62.052374] Subtest basic: SUCCESS (0.005s)
[62.180086] [035/171] (935s left) gem_mmap (basic)
[62.409203] Starting subtest: basic
[62.510803] Subtest basic: SUCCESS (0.000s)
[62.585250] [036/171] (934s left) gem_mmap_gtt (basic)
[62.713966] Starting subtest: basic
[62.733279] Subtest basic: SUCCESS (0.001s)
[62.807445] [037/171] (934s left) gem_render_linear_blits (basic)
[62.944137] Starting subtest: basic
[63.046536] Subtest basic: SUCCESS (0.021s)
[63.120567] [038/171] (934s left) gem_render_tiled_blits (basic)
[63.267429] Starting subtest: basic
[63.386700] Subtest basic: SUCCESS (0.023s)
[63.464577] [039/171] (934s left) gem_ringfill (basic-all)
[63.738288] Starting subtest: basic-all
[64.806057] Subtest basic-all: SUCCESS (1.121s)
[64.923780] [040/171] (932s left) gem_softpin (allocator-basic)
[65.106425] Subtest allocator-basic: SKIP (0.000s)
[65.193974] [041/171] (932s left) gem_softpin (allocator-basic-reserve)
[65.358103] Subtest allocator-basic-reserve: SKIP (0.000s)
[65.438739] [042/171] (932s left) gem_softpin (safe-alignment)
[65.614515] Starting subtest: safe-alignment
[65.636887] Subtest safe-alignment: SUCCESS (0.004s)
[65.723573] [043/171] (932s left) gem_sync (basic-all)
[65.922076] Starting subtest: basic-all
[68.243987] Subtest basic-all: SUCCESS (2.145s)
[68.351226] [044/171] (929s left) gem_sync (basic-each)
[68.541358] Starting subtest: basic-each
[70.590461] Subtest basic-each: SUCCESS (2.076s)
[70.755160] [045/171] (927s left) gem_tiled_blits (basic)
[70.971704] Starting subtest: basic
[70.995386] Subtest basic: SUCCESS (0.012s)
[71.139143] [046/171] (926s left) gem_tiled_fence_blits (basic)
[71.468589] Starting subtest: basic
[71.490165] Subtest basic: SUCCESS (0.006s)
[71.618056] [047/171] (926s left) gem_tiled_pread_basic
[72.017843] [048/171] (926s left) gem_wait (busy@all-engines)
[72.177766] Starting subtest: busy
[72.197350] Starting dynamic subtest: all-engines
[72.692427] Dynamic subtest all-engines: SUCCESS (0.518s)
[72.713033] Subtest busy: SUCCESS (0.518s)
[72.902943] [049/171] (925s left) gem_wait (wait@all-engines)
[73.039136] Starting subtest: wait
[73.060124] Starting dynamic subtest: all-engines
[74.054887] Dynamic subtest all-engines: SUCCESS (1.017s)
[74.074290] Subtest wait: SUCCESS (1.017s)
[74.259272] [050/171] (923s left) i915_getparams_basic (basic-eu-total)
[74.393643] Starting subtest: basic-eu-total
[74.436170] Subtest basic-eu-total: SUCCESS (0.000s)
[74.513689] [051/171] (923s left) i915_getparams_basic (basic-subslice-total)
[74.634397] Starting subtest: basic-subslice-total
[74.677773] Subtest basic-subslice-total: SUCCESS (0.000s)
[74.752837] [052/171] (923s left) i915_hangman (error-state-basic)
[74.900625] Starting subtest: error-state-basic
[74.922063] Subtest error-state-basic: SUCCESS (0.007s)
[74.994487] [053/171] (923s left) i915_pciid
[75.228519] [054/171] (923s left) kms_addfb_basic (addfb25-bad-modifier)
[75.378470] Starting subtest: addfb25-bad-modifier
[75.397841] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[75.545613] [055/171] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[75.680684] Starting subtest: addfb25-framebuffer-vs-set-tiling
[75.702680] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[75.778114] [056/171] (922s left) kms_addfb_basic (addfb25-modifier-no-flag)
[75.914485] Starting subtest: addfb25-modifier-no-flag
[75.935595] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[76.012706] [057/171] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[76.152832] Starting subtest: addfb25-x-tiled-legacy
[76.173593] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[76.268293] [058/171] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[76.410243] Starting subtest: addfb25-x-tiled-mismatch-legacy
[76.428532] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[76.502348] [059/171] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[76.640559] Starting subtest: addfb25-yf-tiled-legacy
[76.659032] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[76.735556] [060/171] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[76.893210] Starting subtest: addfb25-y-tiled-legacy
[76.913226] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[76.992609] [061/171] (921s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[77.148655] Starting subtest: addfb25-y-tiled-small-legacy
[77.190684] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[77.263704] [062/171] (921s left) kms_addfb_basic (bad-pitch-0)
[77.411305] Starting subtest: bad-pitch-0
[77.431187] Subtest bad-pitch-0: SUCCESS (0.000s)
[77.504748] [063/171] (921s left) kms_addfb_basic (bad-pitch-1024)
[77.645922] Starting subtest: bad-pitch-1024
[77.664797] Subtest bad-pitch-1024: SUCCESS (0.000s)
[77.739217] [064/171] (921s left) kms_addfb_basic (bad-pitch-128)
[77.876418] Starting subtest: bad-pitch-128
[77.895133] Subtest bad-pitch-128: SUCCESS (0.000s)
[77.975041] [065/171] (921s left) kms_addfb_basic (bad-pitch-256)
[78.111505] Starting subtest: bad-pitch-256
[78.130128] Subtest bad-pitch-256: SUCCESS (0.000s)
[78.232264] [066/171] (920s left) kms_addfb_basic (bad-pitch-32)
[78.369923] Starting subtest: bad-pitch-32
[78.391065] Subtest bad-pitch-32: SUCCESS (0.000s)
[78.468266] [067/171] (920s left) kms_addfb_basic (bad-pitch-63)
[78.606062] Starting subtest: bad-pitch-63
[78.626522] Subtest bad-pitch-63: SUCCESS (0.000s)
[78.701055] [068/171] (920s left) kms_addfb_basic (bad-pitch-65536)
[78.842213] Starting subtest: bad-pitch-65536
[78.862586] Subtest bad-pitch-65536: SUCCESS (0.000s)
[78.936423] [069/171] (920s left) kms_addfb_basic (bad-pitch-999)
[79.077129] Starting subtest: bad-pitch-999
[79.095852] Subtest bad-pitch-999: SUCCESS (0.000s)
[79.170218] [070/171] (920s left) kms_addfb_basic (basic)
[79.308586] Starting subtest: basic
[79.327209] Subtest basic: SUCCESS (0.000s)
[79.406281] [071/171] (920s left) kms_addfb_basic (basic-x-tiled-legacy)
[79.524875] Starting subtest: basic-x-tiled-legacy
[79.543420] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[79.642056] [072/171] (919s left) kms_addfb_basic (basic-y-tiled-legacy)
[79.776741] Starting subtest: basic-y-tiled-legacy
[79.796797] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[79.878783] [073/171] (919s left) kms_addfb_basic (bo-too-small)
[80.015491] Starting subtest: bo-too-small
[80.037449] Subtest bo-too-small: SUCCESS (0.000s)
[80.132866] [074/171] (919s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[80.274416] Starting subtest: bo-too-small-due-to-tiling
[80.294968] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[80.385898] [075/171] (919s left) kms_addfb_basic (clobberred-modifier)
[80.533022] Starting subtest: clobberred-modifier
[80.552153] Subtest clobberred-modifier: SUCCESS (0.000s)
[80.627400] [076/171] (919s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[80.765120] Starting subtest: framebuffer-vs-set-tiling
[80.783239] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[80.881850] [077/171] (918s left) kms_addfb_basic (invalid-get-prop)
[81.014509] Starting subtest: invalid-get-prop
[81.035968] Subtest invalid-get-prop: SUCCESS (0.000s)
[81.114865] [078/171] (918s left) kms_addfb_basic (invalid-get-prop-any)
[81.251544] Starting subtest: invalid-get-prop-any
[81.272981] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[81.351477] [079/171] (918s left) kms_addfb_basic (invalid-set-prop)
[81.490583] Starting subtest: invalid-set-prop
[81.511277] Subtest invalid-set-prop: SUCCESS (0.000s)
[81.604950] [080/171] (918s left) kms_addfb_basic (invalid-set-prop-any)
[81.727097] Starting subtest: invalid-set-prop-any
[81.748525] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[81.821627] [081/171] (918s left) kms_addfb_basic (no-handle)
[81.965127] Starting subtest: no-handle
[81.984051] Subtest no-handle: SUCCESS (0.000s)
[82.078400] [082/171] (918s left) kms_addfb_basic (size-max)
[82.216864] Starting subtest: size-max
[82.235359] Subtest size-max: SUCCESS (0.000s)
[82.317581] [083/171] (917s left) kms_addfb_basic (small-bo)
[82.452209] Starting subtest: small-bo
[82.470814] Subtest small-bo: SUCCESS (0.000s)
[82.550939] [084/171] (917s left) kms_addfb_basic (tile-pitch-mismatch)
[82.683353] Starting subtest: tile-pitch-mismatch
[82.704496] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[82.783961] [085/171] (917s left) kms_addfb_basic (too-high)
[82.919843] Starting subtest: too-high
[82.940986] Subtest too-high: SUCCESS (0.001s)
[83.016880] [086/171] (917s left) kms_addfb_basic (too-wide)
[83.154912] Starting subtest: too-wide
[83.177146] Subtest too-wide: SUCCESS (0.000s)
[83.251192] [087/171] (917s left) kms_addfb_basic (unused-handle)
[83.390684] Starting subtest: unused-handle
[83.412135] Subtest unused-handle: SUCCESS (0.000s)
[83.485260] [088/171] (916s left) kms_addfb_basic (unused-modifier)
[83.637987] Starting subtest: unused-modifier
[83.656915] Subtest unused-modifier: SUCCESS (0.000s)
[83.730683] [089/171] (916s left) kms_addfb_basic (unused-offsets)
[83.871685] Starting subtest: unused-offsets
[83.890622] Subtest unused-offsets: SUCCESS (0.000s)
[83.965498] [090/171] (916s left) kms_addfb_basic (unused-pitches)
[84.110576] Starting subtest: unused-pitches
[84.131231] Subtest unused-pitches: SUCCESS (0.000s)
[84.212416] [091/171] (916s left) kms_busy (basic)
[84.368029] Starting subtest: basic
[84.389251] Starting dynamic subtest: flip
[85.053390] Dynamic subtest flip: SUCCESS (0.688s)
[85.080237] Starting dynamic subtest: modeset
[85.558634] Dynamic subtest modeset: SUCCESS (0.500s)
[85.577377] Subtest basic: SUCCESS (1.189s)
[85.727966] [092/171] (915s left) kms_chamelium_hpd (dp-hpd-fast)
[85.935161] Subtest dp-hpd-fast: SKIP (0.000s)
[86.067200] [093/171] (914s left) kms_chamelium_edid (dp-edid-read)
[86.293920] Subtest dp-edid-read: SKIP (0.000s)
[86.427482] [094/171] (914s left) kms_chamelium_frames (dp-crc-fast)
[86.629723] Subtest dp-crc-fast: SKIP (0.000s)
[86.757140] [095/171] (914s left) kms_chamelium_hpd (hdmi-hpd-fast)
[86.944727] Subtest hdmi-hpd-fast: SKIP (0.000s)
[87.088167] [096/171] (914s left) kms_chamelium_edid (hdmi-edid-read)
[87.293188] Subtest hdmi-edid-read: SKIP (0.000s)
[87.410107] [097/171] (913s left) kms_chamelium_frames (hdmi-crc-fast)
[87.607403] Subtest hdmi-crc-fast: SKIP (0.000s)
[87.729620] [098/171] (913s left) kms_chamelium_hpd (vga-hpd-fast)
[87.946393] Subtest vga-hpd-fast: SKIP (0.000s)
[88.066143] [099/171] (913s left) kms_chamelium_edid (vga-edid-read)
[88.261935] Subtest vga-edid-read: SKIP (0.000s)
[88.393689] [100/171] (913s left) kms_prop_blob (basic)
[88.539693] Starting subtest: basic
[88.559065] Subtest basic: SUCCESS (0.000s)
[88.635156] [101/171] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[88.778345] Starting subtest: basic-busy-flip-before-cursor-atomic
[89.739162] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.952s)
[89.916404] [102/171] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[90.054278] Starting subtest: basic-busy-flip-before-cursor-legacy
[90.994906] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.943s)
[91.153459] [103/171] (910s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[91.292549] Starting subtest: basic-flip-after-cursor-atomic
[92.217682] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.929s)
[92.384481] [104/171] (909s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[92.526887] Starting subtest: basic-flip-after-cursor-legacy
[93.449894] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.926s)
[93.621701] [105/171] (908s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[93.765434] Starting subtest: basic-flip-after-cursor-varying-size
[94.696951] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.932s)
[94.862264] [106/171] (907s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[95.001938] Starting subtest: basic-flip-before-cursor-atomic
[95.932762] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.927s)
[96.098636] [107/171] (905s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[96.256505] Starting subtest: basic-flip-before-cursor-legacy
[97.202305] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.957s)
[97.369035] [108/171] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[97.503690] Starting subtest: basic-flip-before-cursor-varying-size
[98.455728] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.947s)
[98.625898] [109/171] (903s left) kms_flip (basic-flip-vs-dpms)
[98.790308] Starting subtest: basic-flip-vs-dpms
[98.810401] Starting dynamic subtest: A-VGA1
[99.695794] Dynamic subtest A-VGA1: SUCCESS (0.932s)
[99.722234] Starting dynamic subtest: B-VGA1
[100.585270] Dynamic subtest B-VGA1: SUCCESS (0.882s)
[100.610895] Starting dynamic subtest: C-VGA1
[101.462181] Dynamic subtest C-VGA1: SUCCESS (0.882s)
[101.480770] Subtest basic-flip-vs-dpms: SUCCESS (2.698s)
[101.646425] [110/171] (900s left) kms_flip (basic-flip-vs-modeset)
[101.807903] Starting subtest: basic-flip-vs-modeset
[101.826638] Starting dynamic subtest: A-VGA1
[102.635433] Dynamic subtest A-VGA1: SUCCESS (0.851s)
[102.662352] Starting dynamic subtest: B-VGA1
[103.429680] Dynamic subtest B-VGA1: SUCCESS (0.787s)
[103.458279] Starting dynamic subtest: C-VGA1
[104.234049] Dynamic subtest C-VGA1: SUCCESS (0.792s)
[104.256838] Subtest basic-flip-vs-modeset: SUCCESS (2.433s)
[104.413420] [111/171] (897s left) kms_flip (basic-flip-vs-wf_vblank)
[104.590352] Starting subtest: basic-flip-vs-wf_vblank
[104.618569] Starting dynamic subtest: A-VGA1
[105.718632] Dynamic subtest A-VGA1: SUCCESS (1.155s)
[105.749467] Starting dynamic subtest: B-VGA1
[106.847820] Dynamic subtest B-VGA1: SUCCESS (1.125s)
[106.874255] Starting dynamic subtest: C-VGA1
[107.963625] Dynamic subtest C-VGA1: SUCCESS (1.124s)
[107.984863] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.406s)
[108.183807] [112/171] (894s left) kms_flip (basic-plain-flip)
[108.360179] Starting subtest: basic-plain-flip
[108.382120] Starting dynamic subtest: A-VGA1
[109.200202] Dynamic subtest A-VGA1: SUCCESS (0.860s)
[109.227932] Starting dynamic subtest: B-VGA1
[110.040208] Dynamic subtest B-VGA1: SUCCESS (0.842s)
[110.069768] Starting dynamic subtest: C-VGA1
[110.887400] Dynamic subtest C-VGA1: SUCCESS (0.841s)
[110.910941] Subtest basic-plain-flip: SUCCESS (2.546s)
[111.086873] [113/171] (891s left) kms_force_connector_basic (force-connector-state)
[111.244533] Starting subtest: force-connector-state
[111.386429] Subtest force-connector-state: SUCCESS (0.139s)
[111.601432] [114/171] (890s left) kms_force_connector_basic (force-edid)
[111.737914] Starting subtest: force-edid
[111.802226] Subtest force-edid: SUCCESS (0.063s)
[111.917125] [115/171] (890s left) kms_force_connector_basic (force-load-detect)
[112.050883] Starting subtest: force-load-detect
[112.190223] Subtest force-load-detect: SUCCESS (0.142s)
[112.384333] [116/171] (890s left) kms_force_connector_basic (prune-stale-modes)
[112.520917] Starting subtest: prune-stale-modes
[112.541873] Subtest prune-stale-modes: SUCCESS (0.015s)
[112.657509] [117/171] (890s left) kms_frontbuffer_tracking (basic)
[112.858680] Starting subtest: basic
[114.666442] Subtest basic: SUCCESS (1.860s)
[114.773300] [118/171] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[114.945116] Starting subtest: compare-crc-sanitycheck
[114.966282] Starting dynamic subtest: pipe-A-VGA-1
[115.204830] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.278s)
[115.231860] Starting dynamic subtest: pipe-B-VGA-1
[115.474854] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.266s)
[115.501520] Starting dynamic subtest: pipe-C-VGA-1
[115.749183] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.272s)
[115.769604] Subtest compare-crc-sanitycheck: SUCCESS (0.820s)
[115.908981] [119/171] (887s left) kms_pipe_crc_basic (hang-read-crc)
[116.067309] Starting subtest: hang-read-crc
[116.087294] Starting dynamic subtest: pipe-A-VGA-1
[116.826544] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.761s)
[116.850744] Starting dynamic subtest: pipe-B-VGA-1
[117.586678] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.764s)
[117.613598] Starting dynamic subtest: pipe-C-VGA-1
[118.362725] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.775s)
[118.381154] Subtest hang-read-crc: SUCCESS (2.304s)
[118.522203] [120/171] (884s left) kms_pipe_crc_basic (nonblocking-crc)
[118.666312] Starting subtest: nonblocking-crc
[118.686995] Starting dynamic subtest: pipe-A-VGA-1
[119.127198] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.452s)
[119.151426] Starting dynamic subtest: pipe-B-VGA-1
[119.571510] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.448s)
[119.599521] Starting dynamic subtest: pipe-C-VGA-1
[120.028671] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.452s)
[120.047266] Subtest nonblocking-crc: SUCCESS (1.356s)
[120.184919] [121/171] (882s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[120.321920] Starting subtest: nonblocking-crc-frame-sequence
[120.343212] Starting dynamic subtest: pipe-A-VGA-1
[120.785641] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.453s)
[120.809878] Starting dynamic subtest: pipe-B-VGA-1
[121.229123] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.446s)
[121.255233] Starting dynamic subtest: pipe-C-VGA-1
[121.687545] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.452s)
[121.708068] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.355s)
[121.842652] [122/171] (881s left) kms_pipe_crc_basic (read-crc)
[121.978658] Starting subtest: read-crc
[121.997342] Starting dynamic subtest: pipe-A-VGA-1
[122.374341] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.386s)
[122.400594] Starting dynamic subtest: pipe-B-VGA-1
[122.757135] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.380s)
[122.783019] Starting dynamic subtest: pipe-C-VGA-1
[123.139455] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.385s)
[123.160592] Subtest read-crc: SUCCESS (1.155s)
[123.293614] [123/171] (879s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[123.444151] Starting subtest: read-crc-frame-sequence
[123.462707] Starting dynamic subtest: pipe-A-VGA-1
[123.828532] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.380s)
[123.853871] Starting dynamic subtest: pipe-B-VGA-1
[124.215071] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.381s)
[124.242663] Starting dynamic subtest: pipe-C-VGA-1
[124.619594] Dynamic subtest pipe-C-VGA-1: SUCCESS (0.386s)
[124.642275] Subtest read-crc-frame-sequence: SUCCESS (1.152s)
[124.763802] [124/171] (878s left) kms_psr (primary_page_flip)
[124.952070] Subtest primary_page_flip: SKIP (0.000s)
[125.050841] [125/171] (878s left) kms_psr (cursor_plane_move)
[125.216794] Subtest cursor_plane_move: SKIP (0.000s)
[125.315626] [126/171] (878s left) kms_psr (sprite_plane_onoff)
[125.495589] Subtest sprite_plane_onoff: SKIP (0.000s)
[125.584906] [127/171] (877s left) kms_psr (primary_mmap_gtt)
[125.773337] Subtest primary_mmap_gtt: SKIP (0.000s)
[125.866693] [128/171] (877s left) kms_setmode (basic-clone-single-crtc)
[126.015776] Starting subtest: basic-clone-single-crtc
[126.086181] Subtest basic-clone-single-crtc: SKIP (0.000s)
[126.183901] [129/171] (877s left) i915_pm_backlight (basic-brightness)
[126.350896] Subtest basic-brightness: SKIP (0.000s)
[126.445877] [130/171] (877s left) i915_pm_rpm (basic-pci-d3-state)
[137.973270] Subtest basic-pci-d3-state: SKIP (0.000s)
[138.054362] [131/171] (865s left) i915_pm_rpm (basic-rte)
[138.189419] Starting subtest: basic-rte
[149.353450] Subtest basic-rte: SKIP (11.102s)
[149.468369] [132/171] (854s left) i915_pm_rps (basic-api)
[149.618760] Starting subtest: basic-api
[149.638399] Subtest basic-api: SUCCESS (0.002s)
[149.714536] [133/171] (854s left) prime_self_import (basic-llseek-bad)
[149.862958] Starting subtest: basic-llseek-bad
[149.882340] Subtest basic-llseek-bad: SUCCESS (0.001s)
[149.961592] [134/171] (854s left) prime_self_import (basic-llseek-size)
[150.099075] Starting subtest: basic-llseek-size
[150.118405] Subtest basic-llseek-size: SUCCESS (0.002s)
[150.199305] [135/171] (853s left) prime_self_import (basic-with_fd_dup)
[150.316187] Starting subtest: basic-with_fd_dup
[150.335623] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[150.416206] [136/171] (853s left) prime_self_import (basic-with_one_bo)
[150.550821] Starting subtest: basic-with_one_bo
[150.573181] Subtest basic-with_one_bo: SUCCESS (0.002s)
[150.653751] [137/171] (853s left) prime_self_import (basic-with_one_bo_two_files)
[150.794330] Starting subtest: basic-with_one_bo_two_files
[150.816469] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[150.894829] [138/171] (853s left) prime_self_import (basic-with_two_bos)
[151.034695] Starting subtest: basic-with_two_bos
[151.055976] Subtest basic-with_two_bos: SUCCESS (0.002s)
[151.131612] [139/171] (853s left) prime_vgem (basic-fence-flip)
[151.276464] Starting subtest: basic-fence-flip
[151.579420] Subtest basic-fence-flip: SUCCESS (0.315s)
[151.704965] [140/171] (852s left) prime_vgem (basic-fence-mmap)
[151.839476] Starting subtest: basic-fence-mmap
[151.861477] Subtest basic-fence-mmap: SUCCESS (0.023s)
[151.961636] [141/171] (852s left) prime_vgem (basic-fence-read)
[152.120506] Starting subtest: basic-fence-read
[152.141997] Subtest basic-fence-read: SUCCESS (0.036s)
[152.236212] [142/171] (852s left) prime_vgem (basic-gtt)
[152.375988] Starting subtest: basic-gtt
[152.395400] Subtest basic-gtt: SUCCESS (0.011s)
[152.493776] [143/171] (852s left) prime_vgem (basic-read)
[152.656424] Starting subtest: basic-read
[152.678716] Subtest basic-read: SUCCESS (0.016s)
[152.778757] [144/171] (851s left) prime_vgem (basic-write)
[152.939224] Starting subtest: basic-write
[152.960279] Subtest basic-write: SUCCESS (0.018s)
[153.053348] [145/171] (851s left) prime_vgem (basic-userptr)
[153.195433] Starting subtest: basic-userptr
[153.233914] Subtest basic-userptr: SKIP (0.014s)
[153.334950] [146/171] (851s left) vgem_basic (setversion)
[153.477412] Starting subtest: setversion
[153.521467] Subtest setversion: SUCCESS (0.000s)
[153.600361] [147/171] (851s left) vgem_basic (create)
[153.720309] Starting subtest: create
[153.742179] Subtest create: SUCCESS (0.000s)
[153.820534] [148/171] (851s left) vgem_basic (debugfs)
[153.960859] Starting subtest: debugfs
[153.982191] Subtest debugfs: SUCCESS (0.001s)
[154.058644] [149/171] (851s left) vgem_basic (dmabuf-export)
[154.200193] Starting subtest: dmabuf-export
[154.221563] Subtest dmabuf-export: SUCCESS (0.002s)
[154.295446] [150/171] (850s left) vgem_basic (dmabuf-fence)
[154.438233] Starting subtest: dmabuf-fence
[154.458059] Subtest dmabuf-fence: SUCCESS (0.001s)
[154.532732] [151/171] (850s left) vgem_basic (dmabuf-fence-before)
[154.673956] Starting subtest: dmabuf-fence-before
[154.693576] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[154.771066] [152/171] (850s left) vgem_basic (dmabuf-mmap)
[154.908507] Starting subtest: dmabuf-mmap
[154.927674] Subtest dmabuf-mmap: SUCCESS (0.015s)
[155.006996] [153/171] (850s left) vgem_basic (mmap)
[155.143912] Starting subtest: mmap
[155.163196] Subtest mmap: SUCCESS (0.010s)
[155.244164] [154/171] (850s left) vgem_basic (second-client)
[155.380940] Starting subtest: second-client
[155.426031] Subtest second-client: SUCCESS (0.050s)
[155.504159] [155/171] (849s left) vgem_basic (sysfs)
[155.644299] Starting subtest: sysfs
[155.665439] Subtest sysfs: SUCCESS (0.001s)
[155.741273] [156/171] (849s left) core_hotunplug (unbind-rebind)
[155.957160] Starting subtest: unbind-rebind
[156.634663] Subtest unbind-rebind: SUCCESS (0.689s)
[156.735453] [157/171] (848s left) vgem_basic (unload)
[156.889182] Starting subtest: unload
[185.836263] Subtest unload: SUCCESS (28.772s)
[185.916210] [158/171] (819s left) i915_module_load (reload)
[186.041855] Starting subtest: reload
[187.867432] Subtest reload: SUCCESS (1.835s)
[187.960959] [159/171] (817s left) gem_lmem_swapping (basic)
[188.138465] Subtest basic: SKIP (0.000s)
[188.212993] [160/171] (817s left) gem_lmem_swapping (parallel-random-engines)
[188.374292] Subtest parallel-random-engines: SKIP (0.000s)
[188.452565] [161/171] (817s left) gem_lmem_swapping (random-engines)
[188.607758] Subtest random-engines: SKIP (0.000s)
[188.687251] [162/171] (817s left) gem_lmem_swapping (verify-random)
[188.843736] Subtest verify-random: SKIP (0.000s)
[188.924140] [163/171] (817s left) i915_pm_rpm (module-reload)
[200.413026] Subtest module-reload: SKIP (0.000s)
[200.493251] [164/171] (805s left) i915_selftest (live)
[201.235957] Starting subtest: live
[201.254777] Starting dynamic subtest: sanitycheck
[201.830935] Dynamic subtest sanitycheck: SUCCESS (0.592s)
[201.858153] Starting dynamic subtest: uncore
[202.332584] Dynamic subtest uncore: SUCCESS (0.504s)
[202.357444] Starting dynamic subtest: workarounds
[202.946558] Dynamic subtest workarounds: SUCCESS (0.609s)
[202.976742] Starting dynamic subtest: gt_engines
[203.446132] Dynamic subtest gt_engines: SUCCESS (0.497s)
[203.481623] Starting dynamic subtest: gt_timelines
[208.388739] Dynamic subtest gt_timelines: SUCCESS (4.942s)
[208.421061] Starting dynamic subtest: gt_contexts
[208.998858] Dynamic subtest gt_contexts: SUCCESS (0.609s)
[209.031081] Starting dynamic subtest: gt_lrc
[209.507163] Dynamic subtest gt_lrc: SUCCESS (0.507s)
[209.541645] Starting dynamic subtest: gt_mocs
[210.040248] Dynamic subtest gt_mocs: SUCCESS (0.531s)
[210.070889] Starting dynamic subtest: gt_pm
[218.611135] Dynamic subtest gt_pm: SUCCESS (8.577s)
[218.638429] Starting dynamic subtest: gt_heartbeat
[219.211203] Dynamic subtest gt_heartbeat: SUCCESS (0.602s)
[219.238541] Starting dynamic subtest: requests
[224.402732] Dynamic subtest requests: SUCCESS (5.191s)
[224.430497] Starting dynamic subtest: migrate
[224.883366] Dynamic subtest migrate: SUCCESS (0.478s)
[224.910889] Starting dynamic subtest: active
[225.445293] Dynamic subtest active: SUCCESS (0.562s)
[225.472825] Starting dynamic subtest: objects
[226.401264] Dynamic subtest objects: SUCCESS (0.957s)
[226.426095] Starting dynamic subtest: mman
[230.251160] Dynamic subtest mman: SUCCESS (3.846s)
[230.282292] Starting dynamic subtest: dmabuf
[230.823531] Dynamic subtest dmabuf: SUCCESS (0.573s)
[230.848382] Starting dynamic subtest: vma
[231.377317] Dynamic subtest vma: SUCCESS (0.550s)
[231.405390] Starting dynamic subtest: coherency
[233.006885] Dynamic subtest coherency: SUCCESS (1.632s)
[233.032146] Starting dynamic subtest: gtt
[236.730408] Dynamic subtest gtt: SUCCESS (3.723s)
[236.756768] Starting dynamic subtest: gem
[237.354542] Dynamic subtest gem: SUCCESS (0.622s)
[237.379314] Starting dynamic subtest: evict
[237.896914] Dynamic subtest evict: SUCCESS (0.541s)
[237.924489] Starting dynamic subtest: hugepages
[239.566067] Dynamic subtest hugepages: SUCCESS (1.667s)
[239.591979] Starting dynamic subtest: gem_contexts
[243.780719] Dynamic subtest gem_contexts: SUCCESS (4.214s)
[243.807995] Starting dynamic subtest: client
[244.342850] Dynamic subtest client: SUCCESS (0.563s)
[244.368020] Starting dynamic subtest: gem_migrate
[244.895344] Dynamic subtest gem_migrate: SUCCESS (0.549s)
[244.922287] Starting dynamic subtest: reset
[245.439907] Dynamic subtest reset: SUCCESS (0.547s)
[245.464816] Starting dynamic subtest: memory_region
[245.975175] Dynamic subtest memory_region: SUCCESS (0.533s)
[246.001900] Starting dynamic subtest: hangcheck
[259.238112] Dynamic subtest hangcheck: SUCCESS (13.261s)
[259.265504] Starting dynamic subtest: execlists
[259.751554] Dynamic subtest execlists: SUCCESS (0.516s)
[259.776711] Starting dynamic subtest: ring_submission
[260.320993] Dynamic subtest ring_submission: SUCCESS (0.566s)
[260.348732] Starting dynamic subtest: perf
[260.862749] Dynamic subtest perf: SUCCESS (0.544s)
[260.888024] Starting dynamic subtest: slpc
[261.366652] Dynamic subtest slpc: SUCCESS (0.501s)
[261.393689] Starting dynamic subtest: guc
[261.902437] Dynamic subtest guc: SUCCESS (0.538s)
[261.927193] Starting dynamic subtest: guc_multi_lrc
[262.449097] Dynamic subtest guc_multi_lrc: SUCCESS (0.543s)
[262.476147] Starting dynamic subtest: guc_hang
[262.924462] Dynamic subtest guc_hang: SUCCESS (0.471s)
[262.954297] Starting dynamic subtest: late_gt_pm
[263.480931] Dynamic subtest late_gt_pm: SUCCESS (0.554s)
[263.508081] Subtest live: SUCCESS (62.236s)
[263.795679] [165/171] (742s left) dmabuf (all-tests)
[263.981619] Starting subtest: all-tests
[264.005913] Starting dynamic subtest: sanitycheck
[264.028963] Dynamic subtest sanitycheck: SUCCESS (0.039s)
[264.056154] Starting dynamic subtest: dma_fence
[264.162512] Dynamic subtest dma_fence: SUCCESS (0.142s)
[264.197878] Starting dynamic subtest: dma_fence_chain
[276.019749] Dynamic subtest dma_fence_chain: SUCCESS (11.765s)
[276.045078] Starting dynamic subtest: dma_fence_unwrap
[276.064351] Dynamic subtest dma_fence_unwrap: SUCCESS (0.028s)
[276.087527] Starting dynamic subtest: dma_resv
[276.109454] Dynamic subtest dma_resv: SUCCESS (0.031s)
[276.131327] Subtest all-tests: SUCCESS (12.010s)
[276.208897] [166/171] (730s left) i915_suspend (basic-s2idle-without-i915)
[276.339426] Starting subtest: basic-s2idle-without-i915
[293.308535] Subtest basic-s2idle-without-i915: SUCCESS (2.346s)
[295.863366] [167/171] (727s left) i915_suspend (basic-s3-without-i915)
[296.003895] Starting subtest: basic-s3-without-i915
[314.146239] Subtest basic-s3-without-i915: SUCCESS (1.888s)
[317.096911] [168/171] (725s left) gem_exec_suspend (basic-s0)
[317.251631] Starting subtest: basic-S0
[317.270164] Starting dynamic subtest: smem
[334.105201] Dynamic subtest smem: SUCCESS (1.769s)
[334.124282] Subtest basic-S0: SUCCESS (1.769s)
[337.535338] [169/171] (723s left) gem_exec_suspend (basic-s3)
[337.670561] Starting subtest: basic-S3
[337.691338] Starting dynamic subtest: smem
[354.943002] Dynamic subtest smem: SUCCESS (1.697s)
[354.961482] Subtest basic-S3: SUCCESS (1.697s)
[358.317893] [170/171] (721s left) kms_chamelium_hpd (common-hpd-after-suspend)
[358.519090] Subtest common-hpd-after-suspend: SKIP (0.000s)
[358.641986] [171/171] (721s left) kms_pipe_crc_basic (suspend-read-crc)
[358.776931] Starting subtest: suspend-read-crc
[358.795557] Starting dynamic subtest: pipe-A-VGA-1
[377.116997] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.804s)
[377.146194] Starting dynamic subtest: pipe-B-VGA-1
[395.128036] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.848s)
[395.155581] Starting dynamic subtest: pipe-C-VGA-1
[413.135456] Dynamic subtest pipe-C-VGA-1: SUCCESS (1.858s)
[413.156099] Subtest suspend-read-crc: SUCCESS (5.516s)
[416.254418] Closing watchdogs
Done.