[23.517320] Initializing watchdogs
[23.517368]   /dev/watchdog0
[23.526250] [001/171] (960s left) i915_module_load (load)
[23.579179] Starting subtest: load
[24.852632] Subtest load: SUCCESS (1.274s)
[24.872258] [002/171] (959s left) core_auth (basic-auth)
[24.954923] Starting subtest: basic-auth
[24.960557] Subtest basic-auth: SUCCESS (0.001s)
[24.980103] [003/171] (959s left) debugfs_test (read_all_entries)
[25.030457] Starting subtest: read_all_entries
[25.108669] Subtest read_all_entries: SUCCESS (0.083s)
[25.136995] [004/171] (958s left) debugfs_test (basic-hwmon)
[25.192221] Starting subtest: basic-hwmon
[25.203239] Subtest basic-hwmon: SKIP (0.000s)
[25.223260] [005/171] (958s left) fbdev (eof)
[25.606690] Subtest eof: SKIP (0.000s)
[25.628006] [006/171] (958s left) fbdev (info)
[25.683618] Subtest info: SKIP (0.000s)
[25.703468] [007/171] (958s left) fbdev (nullptr)
[25.753945] Subtest nullptr: SKIP (0.000s)
[25.777876] [008/171] (958s left) fbdev (read)
[25.842722] Subtest read: SKIP (0.000s)
[25.862256] [009/171] (958s left) fbdev (write)
[25.916721] Subtest write: SKIP (0.000s)
[25.936936] [010/171] (958s left) gem_basic (bad-close)
[25.986170] Starting subtest: bad-close
[25.997151] Subtest bad-close: SUCCESS (0.000s)
[26.017061] [011/171] (958s left) gem_basic (create-close)
[26.072765] Starting subtest: create-close
[26.084145] Subtest create-close: SUCCESS (0.000s)
[26.103847] [012/171] (958s left) gem_basic (create-fd-close)
[26.159991] Starting subtest: create-fd-close
[26.171793] Subtest create-fd-close: SUCCESS (0.000s)
[26.192205] [013/171] (958s left) gem_busy (busy@all-engines)
[26.247610] Starting subtest: busy
[26.253091] Starting dynamic subtest: all-engines
[26.270300] Dynamic subtest all-engines: SUCCESS (0.020s)
[26.276081] Subtest busy: SUCCESS (0.021s)
[26.557430] [014/171] (957s left) gem_close_race (basic-process)
[26.623079] Starting subtest: basic-process
[26.653225] Subtest basic-process: SUCCESS (0.034s)
[26.785111] [015/171] (957s left) gem_close_race (basic-threads)
[26.851761] Starting subtest: basic-threads
[28.050821] Subtest basic-threads: SUCCESS (1.205s)
[28.182286] [016/171] (956s left) gem_ctx_create (basic)
[28.257964] Starting subtest: basic
[28.264244] Subtest basic: SUCCESS (0.000s)
[28.382765] [017/171] (956s left) gem_ctx_create (basic-files)
[28.457467] Starting subtest: basic-files
[30.488591] Subtest basic-files: SUCCESS (2.037s)
[30.786461] [018/171] (953s left) gem_ctx_exec (basic)
[30.851519] Starting subtest: basic
[30.856978] Subtest basic: SUCCESS (0.003s)
[30.891090] [019/171] (953s left) gem_exec_basic (basic)
[30.953997] Starting subtest: basic
[30.959586] Starting dynamic subtest: rcs0-smem
[30.965299] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[30.978452] Starting dynamic subtest: bcs0-smem
[30.984378] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[30.997716] Starting dynamic subtest: vcs0-smem
[31.003517] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[31.017035] Starting dynamic subtest: vcs1-smem
[31.023452] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[31.037328] Starting dynamic subtest: vecs0-smem
[31.044200] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[31.050717] Subtest basic: SUCCESS (0.004s)
[31.086071] [020/171] (953s left) gem_exec_create (basic)
[31.152810] Starting subtest: basic
[31.158342] Starting dynamic subtest: smem
[33.237194] Dynamic subtest smem: SUCCESS (2.089s)
[33.243083] Subtest basic: SUCCESS (2.089s)
[33.375362] [021/171] (951s left) gem_exec_fence (basic-busy)
[33.555439] Starting subtest: basic-busy
[33.561274] Starting dynamic subtest: rcs0
[33.614552] Dynamic subtest rcs0: SUCCESS (0.059s)
[33.628198] Starting dynamic subtest: bcs0
[33.667968] Dynamic subtest bcs0: SUCCESS (0.053s)
[33.681650] Starting dynamic subtest: vcs0
[33.716773] Dynamic subtest vcs0: SUCCESS (0.048s)
[33.730570] Starting dynamic subtest: vcs1
[33.764967] Dynamic subtest vcs1: SUCCESS (0.048s)
[33.778724] Starting dynamic subtest: vecs0
[33.816411] Dynamic subtest vecs0: SUCCESS (0.051s)
[33.822504] Subtest basic-busy: SUCCESS (0.260s)
[34.268247] [022/171] (950s left) gem_exec_fence (basic-wait)
[34.430860] Starting subtest: basic-wait
[34.436291] Starting dynamic subtest: rcs0
[34.502296] Dynamic subtest rcs0: SUCCESS (0.073s)
[34.513897] Starting dynamic subtest: bcs0
[34.555413] Dynamic subtest bcs0: SUCCESS (0.053s)
[34.569996] Starting dynamic subtest: vcs0
[34.609145] Dynamic subtest vcs0: SUCCESS (0.054s)
[34.623825] Starting dynamic subtest: vcs1
[34.661123] Dynamic subtest vcs1: SUCCESS (0.052s)
[34.675901] Starting dynamic subtest: vecs0
[34.713430] Dynamic subtest vecs0: SUCCESS (0.052s)
[34.720199] Subtest basic-wait: SUCCESS (0.284s)
[35.170093] [023/171] (949s left) gem_exec_fence (basic-await)
[35.348807] Starting subtest: basic-await
[35.355253] Starting dynamic subtest: rcs0
[35.432146] Dynamic subtest rcs0: SUCCESS (0.084s)
[35.439770] Starting dynamic subtest: bcs0
[35.497187] Dynamic subtest bcs0: SUCCESS (0.065s)
[35.506255] Starting dynamic subtest: vcs0
[35.565594] Dynamic subtest vcs0: SUCCESS (0.068s)
[35.579300] Starting dynamic subtest: vcs1
[35.643453] Dynamic subtest vcs1: SUCCESS (0.078s)
[35.652106] Starting dynamic subtest: vecs0
[35.711581] Dynamic subtest vecs0: SUCCESS (0.068s)
[35.717211] Subtest basic-await: SUCCESS (0.363s)
[36.133181] [024/171] (948s left) gem_exec_fence (nb-await)
[36.307633] Starting subtest: nb-await
[36.313488] Starting dynamic subtest: rcs0
[36.371204] Dynamic subtest rcs0: SUCCESS (0.063s)
[36.379080] Starting dynamic subtest: bcs0
[36.429640] Dynamic subtest bcs0: SUCCESS (0.059s)
[36.443377] Starting dynamic subtest: vcs0
[36.487781] Dynamic subtest vcs0: SUCCESS (0.058s)
[36.502108] Starting dynamic subtest: vcs1
[36.549778] Dynamic subtest vcs1: SUCCESS (0.062s)
[36.564485] Starting dynamic subtest: vecs0
[36.610364] Dynamic subtest vecs0: SUCCESS (0.061s)
[36.616640] Subtest nb-await: SUCCESS (0.303s)
[37.059583] [025/171] (947s left) gem_exec_gttfill (basic)
[37.134818] Starting subtest: basic
[39.663311] Subtest basic: SUCCESS (2.532s)
[39.788089] [026/171] (944s left) gem_exec_parallel (engines)
[39.867474] Starting subtest: engines
[39.873113] Starting dynamic subtest: basic
[41.337268] Dynamic subtest basic: SUCCESS (1.474s)
[41.347111] Starting dynamic subtest: contexts
[43.059597] Dynamic subtest contexts: SUCCESS (1.714s)
[43.068093] Starting dynamic subtest: fds
[44.935682] Dynamic subtest fds: SUCCESS (1.883s)
[44.944328] Starting dynamic subtest: userptr
[46.387060] Dynamic subtest userptr: SUCCESS (1.452s)
[46.393472] Subtest engines: SUCCESS (6.524s)
[46.539353] [027/171] (938s left) gem_exec_store (basic)
[46.628232] Starting subtest: basic
[46.695253] Subtest basic: SUCCESS (0.087s)
[46.839374] [028/171] (937s left) gem_flink_basic (bad-flink)
[46.908921] Starting subtest: bad-flink
[46.914896] Subtest bad-flink: SUCCESS (0.000s)
[46.944436] [029/171] (937s left) gem_flink_basic (bad-open)
[47.009620] Starting subtest: bad-open
[47.015106] Subtest bad-open: SUCCESS (0.000s)
[47.044616] [030/171] (937s left) gem_flink_basic (basic)
[47.110796] Starting subtest: basic
[47.116865] Subtest basic: SUCCESS (0.000s)
[47.147173] [031/171] (937s left) gem_flink_basic (double-flink)
[47.216886] Starting subtest: double-flink
[47.222888] Subtest double-flink: SUCCESS (0.000s)
[47.253047] [032/171] (937s left) gem_flink_basic (flink-lifetime)
[47.329682] Starting subtest: flink-lifetime
[47.335474] Subtest flink-lifetime: SUCCESS (0.001s)
[47.365380] [033/171] (937s left) gem_huc_copy (huc-copy)
[47.431929] Starting subtest: huc-copy
[47.437688] Subtest huc-copy: SUCCESS (0.003s)
[47.490353] [034/171] (937s left) gem_linear_blits (basic)
[47.617190] Starting subtest: basic
[47.623144] Subtest basic: SUCCESS (0.004s)
[47.688511] [035/171] (937s left) gem_mmap (basic)
[47.790403] Starting subtest: basic
[47.818768] Subtest basic: SUCCESS (0.000s)
[47.848778] [036/171] (937s left) gem_mmap_gtt (basic)
[47.921979] Starting subtest: basic
[47.927892] Subtest basic: SUCCESS (0.000s)
[47.957882] [037/171] (937s left) gem_render_linear_blits (basic)
[48.026513] Starting subtest: basic
[48.054067] Subtest basic: SUCCESS (0.024s)
[48.103976] [038/171] (937s left) gem_render_tiled_blits (basic)
[48.179728] Starting subtest: basic
[48.213240] Subtest basic: SUCCESS (0.030s)
[48.264236] [039/171] (936s left) gem_ringfill (basic-all)
[48.644060] Starting subtest: basic-all
[49.762171] Subtest basic-all: SUCCESS (1.114s)
[49.820664] [040/171] (935s left) gem_softpin (allocator-basic)
[49.895998] Starting subtest: allocator-basic
[49.933424] Subtest allocator-basic: SUCCESS (0.045s)
[49.987162] [041/171] (935s left) gem_softpin (allocator-basic-reserve)
[50.047058] Starting subtest: allocator-basic-reserve
[50.080029] Subtest allocator-basic-reserve: SUCCESS (0.041s)
[50.131795] [042/171] (935s left) gem_softpin (safe-alignment)
[50.190965] Starting subtest: safe-alignment
[50.196486] Subtest safe-alignment: SUCCESS (0.010s)
[50.245319] [043/171] (935s left) gem_sync (basic-all)
[50.356974] Starting subtest: basic-all
[52.378944] Subtest basic-all: SUCCESS (2.064s)
[52.516630] [044/171] (932s left) gem_sync (basic-each)
[52.631689] Starting subtest: basic-each
[55.014107] Subtest basic-each: SUCCESS (2.424s)
[55.157843] [045/171] (930s left) gem_tiled_blits (basic)
[55.247205] Starting subtest: basic
[55.258644] Subtest basic: SUCCESS (0.009s)
[55.324200] [046/171] (930s left) gem_tiled_fence_blits (basic)
[55.475523] Starting subtest: basic
[55.488414] Subtest basic: SUCCESS (0.013s)
[55.552370] [047/171] (929s left) gem_tiled_pread_basic
[55.685762] [048/171] (929s left) gem_wait (busy@all-engines)
[55.737291] Starting subtest: busy
[55.742805] Starting dynamic subtest: all-engines
[56.284177] Dynamic subtest all-engines: SUCCESS (0.549s)
[56.290196] Subtest busy: SUCCESS (0.549s)
[56.451321] [049/171] (929s left) gem_wait (wait@all-engines)
[56.531548] Starting subtest: wait
[56.537256] Starting dynamic subtest: all-engines
[57.577258] Dynamic subtest all-engines: SUCCESS (1.051s)
[57.583793] Subtest wait: SUCCESS (1.051s)
[57.738227] [050/171] (927s left) i915_getparams_basic (basic-eu-total)
[57.795915] Starting subtest: basic-eu-total
[57.807171] Subtest basic-eu-total: SUCCESS (0.000s)
[57.842165] [051/171] (927s left) i915_getparams_basic (basic-subslice-total)
[57.908802] Starting subtest: basic-subslice-total
[57.920094] Subtest basic-subslice-total: SUCCESS (0.000s)
[57.950402] [052/171] (927s left) i915_hangman (error-state-basic)
[58.017379] Starting subtest: error-state-basic
[58.093528] Subtest error-state-basic: SUCCESS (0.077s)
[58.116578] [053/171] (927s left) i915_pciid
[58.228630] [054/171] (927s left) kms_addfb_basic (addfb25-bad-modifier)
[58.293928] Starting subtest: addfb25-bad-modifier
[58.299667] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[58.337162] [055/171] (927s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[58.400369] Starting subtest: addfb25-framebuffer-vs-set-tiling
[58.405921] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[58.432433] [056/171] (927s left) kms_addfb_basic (addfb25-modifier-no-flag)
[58.488938] Starting subtest: addfb25-modifier-no-flag
[58.494722] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[58.534551] [057/171] (927s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[58.607815] Starting subtest: addfb25-x-tiled-legacy
[58.613752] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[58.647170] [058/171] (927s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[58.716484] Starting subtest: addfb25-x-tiled-mismatch-legacy
[58.722081] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[58.759468] [059/171] (927s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[58.837029] Starting subtest: addfb25-yf-tiled-legacy
[58.842694] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[58.870431] [060/171] (926s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[58.943920] Starting subtest: addfb25-y-tiled-legacy
[58.949808] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[58.971955] [061/171] (926s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[59.041697] Starting subtest: addfb25-y-tiled-small-legacy
[59.047426] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[59.069171] [062/171] (926s left) kms_addfb_basic (bad-pitch-0)
[59.129073] Starting subtest: bad-pitch-0
[59.134820] Subtest bad-pitch-0: SUCCESS (0.000s)
[59.157203] [063/171] (926s left) kms_addfb_basic (bad-pitch-1024)
[59.213510] Starting subtest: bad-pitch-1024
[59.219319] Subtest bad-pitch-1024: SUCCESS (0.000s)
[59.251134] [064/171] (926s left) kms_addfb_basic (bad-pitch-128)
[59.313170] Starting subtest: bad-pitch-128
[59.318886] Subtest bad-pitch-128: SUCCESS (0.000s)
[59.345261] [065/171] (926s left) kms_addfb_basic (bad-pitch-256)
[59.403842] Starting subtest: bad-pitch-256
[59.409440] Subtest bad-pitch-256: SUCCESS (0.000s)
[59.443525] [066/171] (926s left) kms_addfb_basic (bad-pitch-32)
[59.506774] Starting subtest: bad-pitch-32
[59.512619] Subtest bad-pitch-32: SUCCESS (0.000s)
[59.545112] [067/171] (926s left) kms_addfb_basic (bad-pitch-63)
[59.608891] Starting subtest: bad-pitch-63
[59.614716] Subtest bad-pitch-63: SUCCESS (0.000s)
[59.639026] [068/171] (926s left) kms_addfb_basic (bad-pitch-65536)
[59.697810] Starting subtest: bad-pitch-65536
[59.703319] Subtest bad-pitch-65536: SUCCESS (0.000s)
[59.724728] [069/171] (926s left) kms_addfb_basic (bad-pitch-999)
[59.780639] Starting subtest: bad-pitch-999
[59.786239] Subtest bad-pitch-999: SUCCESS (0.000s)
[59.817013] [070/171] (926s left) kms_addfb_basic (basic)
[59.878474] Starting subtest: basic
[59.884137] Subtest basic: SUCCESS (0.000s)
[59.914944] [071/171] (926s left) kms_addfb_basic (basic-x-tiled-legacy)
[59.980965] Starting subtest: basic-x-tiled-legacy
[59.986641] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[60.013091] [072/171] (926s left) kms_addfb_basic (basic-y-tiled-legacy)
[60.070241] Starting subtest: basic-y-tiled-legacy
[60.075951] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[60.104312] [073/171] (925s left) kms_addfb_basic (bo-too-small)
[60.166331] Starting subtest: bo-too-small
[60.172039] Subtest bo-too-small: SUCCESS (0.000s)
[60.194426] [074/171] (925s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[60.255601] Starting subtest: bo-too-small-due-to-tiling
[60.261185] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[60.285897] [075/171] (925s left) kms_addfb_basic (clobberred-modifier)
[60.340562] Starting subtest: clobberred-modifier
[60.346097] Subtest clobberred-modifier: SUCCESS (0.000s)
[60.383432] [076/171] (925s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[60.438066] Starting subtest: framebuffer-vs-set-tiling
[60.443599] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[60.474230] [077/171] (925s left) kms_addfb_basic (invalid-get-prop)
[60.529664] Starting subtest: invalid-get-prop
[60.535080] Subtest invalid-get-prop: SUCCESS (0.000s)
[60.578293] [078/171] (925s left) kms_addfb_basic (invalid-get-prop-any)
[60.642471] Starting subtest: invalid-get-prop-any
[60.648021] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[60.680858] [079/171] (925s left) kms_addfb_basic (invalid-set-prop)
[60.746030] Starting subtest: invalid-set-prop
[60.751560] Subtest invalid-set-prop: SUCCESS (0.000s)
[60.780669] [080/171] (925s left) kms_addfb_basic (invalid-set-prop-any)
[60.839353] Starting subtest: invalid-set-prop-any
[60.845099] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[60.867464] [081/171] (925s left) kms_addfb_basic (no-handle)
[60.922578] Starting subtest: no-handle
[60.928166] Subtest no-handle: SUCCESS (0.000s)
[60.957058] [082/171] (925s left) kms_addfb_basic (size-max)
[61.019208] Starting subtest: size-max
[61.024901] Subtest size-max: SUCCESS (0.000s)
[61.047112] [083/171] (925s left) kms_addfb_basic (small-bo)
[61.121179] Starting subtest: small-bo
[61.126882] Subtest small-bo: SUCCESS (0.000s)
[61.148683] [084/171] (925s left) kms_addfb_basic (tile-pitch-mismatch)
[61.211053] Starting subtest: tile-pitch-mismatch
[61.216550] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[61.238627] [085/171] (925s left) kms_addfb_basic (too-high)
[61.299709] Starting subtest: too-high
[61.305028] Subtest too-high: SUCCESS (0.000s)
[61.329570] [086/171] (925s left) kms_addfb_basic (too-wide)
[61.400996] Starting subtest: too-wide
[61.406446] Subtest too-wide: SUCCESS (0.000s)
[61.443155] [087/171] (924s left) kms_addfb_basic (unused-handle)
[61.510882] Starting subtest: unused-handle
[61.516583] Subtest unused-handle: SUCCESS (0.000s)
[61.539900] [088/171] (924s left) kms_addfb_basic (unused-modifier)
[61.597822] Starting subtest: unused-modifier
[61.603426] Subtest unused-modifier: SUCCESS (0.000s)
[61.627612] [089/171] (924s left) kms_addfb_basic (unused-offsets)
[61.685090] Starting subtest: unused-offsets
[61.690611] Subtest unused-offsets: SUCCESS (0.000s)
[61.711919] [090/171] (924s left) kms_addfb_basic (unused-pitches)
[61.766962] Starting subtest: unused-pitches
[61.772674] Subtest unused-pitches: SUCCESS (0.000s)
[61.804716] [091/171] (924s left) kms_busy (basic)
[61.885885] Subtest basic: SKIP (0.000s)
[61.907808] [092/171] (924s left) kms_chamelium_hpd (dp-hpd-fast)
[61.985405] Subtest dp-hpd-fast: SKIP (0.000s)
[62.005941] [093/171] (924s left) kms_chamelium_edid (dp-edid-read)
[62.078418] Subtest dp-edid-read: SKIP (0.000s)
[62.099182] [094/171] (924s left) kms_chamelium_frames (dp-crc-fast)
[62.166031] Subtest dp-crc-fast: SKIP (0.000s)
[62.186911] [095/171] (924s left) kms_chamelium_hpd (hdmi-hpd-fast)
[62.258876] Subtest hdmi-hpd-fast: SKIP (0.000s)
[62.279599] [096/171] (924s left) kms_chamelium_edid (hdmi-edid-read)
[62.356865] Subtest hdmi-edid-read: SKIP (0.000s)
[62.382841] [097/171] (924s left) kms_chamelium_frames (hdmi-crc-fast)
[62.461271] Subtest hdmi-crc-fast: SKIP (0.000s)
[62.482261] [098/171] (924s left) kms_chamelium_hpd (vga-hpd-fast)
[62.559656] Subtest vga-hpd-fast: SKIP (0.000s)
[62.580321] [099/171] (924s left) kms_chamelium_edid (vga-edid-read)
[62.654987] Subtest vga-edid-read: SKIP (0.000s)
[62.675867] [100/171] (924s left) kms_prop_blob (basic)
[62.735676] Starting subtest: basic
[62.741158] Subtest basic: SUCCESS (0.000s)
[62.767470] [101/171] (923s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[62.874132] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[62.913524] [102/171] (923s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[63.019356] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[63.058547] [103/171] (923s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[63.162558] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[63.200050] [104/171] (923s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[63.303462] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[63.341071] [105/171] (923s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[63.450767] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[63.487985] [106/171] (923s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[63.591980] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[63.626075] [107/171] (923s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[63.731838] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[63.769985] [108/171] (923s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[63.874728] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[63.912153] [109/171] (923s left) kms_flip (basic-flip-vs-dpms)
[63.993102] Starting subtest: basic-flip-vs-dpms
[64.004066] Subtest basic-flip-vs-dpms: SKIP (0.001s)
[64.035048] [110/171] (923s left) kms_flip (basic-flip-vs-modeset)
[64.114869] Starting subtest: basic-flip-vs-modeset
[64.126158] Subtest basic-flip-vs-modeset: SKIP (0.001s)
[64.158291] [111/171] (922s left) kms_flip (basic-flip-vs-wf_vblank)
[64.237312] Starting subtest: basic-flip-vs-wf_vblank
[64.248793] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s)
[64.269815] [112/171] (922s left) kms_flip (basic-plain-flip)
[64.339061] Starting subtest: basic-plain-flip
[64.350884] Subtest basic-plain-flip: SKIP (0.002s)
[64.372725] [113/171] (922s left) kms_force_connector_basic (force-connector-state)
[64.431089] Starting subtest: force-connector-state
[64.792690] Subtest force-connector-state: SUCCESS (0.360s)
[64.903957] [114/171] (922s left) kms_force_connector_basic (force-edid)
[64.965814] Starting subtest: force-edid
[65.117201] Subtest force-edid: SUCCESS (0.153s)
[65.193073] [115/171] (922s left) kms_force_connector_basic (force-load-detect)
[65.252923] Starting subtest: force-load-detect
[65.263623] Subtest force-load-detect: SKIP (0.000s)
[65.307714] [116/171] (921s left) kms_force_connector_basic (prune-stale-modes)
[65.369779] Starting subtest: prune-stale-modes
[65.526278] Subtest prune-stale-modes: SUCCESS (0.159s)
[65.614592] [117/171] (921s left) kms_frontbuffer_tracking (basic)
[65.692382] Subtest basic: SKIP (0.000s)
[65.724258] [118/171] (921s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[65.798034] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[65.827084] [119/171] (921s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[65.901386] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[65.931477] [120/171] (921s left) kms_pipe_crc_basic (hang-read-crc)
[66.003613] Subtest hang-read-crc: SKIP (0.000s)
[66.029748] [121/171] (921s left) kms_pipe_crc_basic (nonblocking-crc)
[66.106576] Subtest nonblocking-crc: SKIP (0.000s)
[66.132480] [122/171] (921s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[66.208694] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[66.229805] [123/171] (921s left) kms_pipe_crc_basic (read-crc)
[66.304991] Subtest read-crc: SKIP (0.000s)
[66.328310] [124/171] (921s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[66.407083] Subtest read-crc-frame-sequence: SKIP (0.000s)
[66.427839] [125/171] (921s left) kms_psr (primary_page_flip)
[66.492700] Subtest primary_page_flip: SKIP (0.000s)
[66.518119] [126/171] (920s left) kms_psr (cursor_plane_move)
[66.589893] Subtest cursor_plane_move: SKIP (0.000s)
[66.616804] [127/171] (920s left) kms_psr (sprite_plane_onoff)
[66.684640] Subtest sprite_plane_onoff: SKIP (0.000s)
[66.707939] [128/171] (920s left) kms_psr (primary_mmap_gtt)
[66.779764] Subtest primary_mmap_gtt: SKIP (0.000s)
[66.807435] [129/171] (920s left) kms_setmode (basic-clone-single-crtc)
[66.883967] Starting subtest: basic-clone-single-crtc
[66.901359] Subtest basic-clone-single-crtc: SKIP (0.000s)
[66.931308] [130/171] (920s left) i915_pm_backlight (basic-brightness)
[67.014556] Subtest basic-brightness: SKIP (0.000s)
[67.036294] [131/171] (920s left) i915_pm_rpm (basic-pci-d3-state)
[78.795347] Subtest basic-pci-d3-state: SKIP (0.000s)
[78.916264] [132/171] (908s left) i915_pm_rpm (basic-rte)
[78.975167] Starting subtest: basic-rte
[91.421803] Subtest basic-rte: FAIL (11.929s)
[91.472997] [133/171] (896s left) i915_pm_rps (basic-api)
[91.541143] Starting subtest: basic-api
[91.552514] Subtest basic-api: SKIP (0.001s)
[91.581917] [134/171] (896s left) prime_self_import (basic-llseek-bad)
[91.651030] Starting subtest: basic-llseek-bad
[91.662352] Subtest basic-llseek-bad: SUCCESS (0.001s)
[91.713395] [135/171] (896s left) prime_self_import (basic-llseek-size)
[91.769700] Starting subtest: basic-llseek-size
[91.780888] Subtest basic-llseek-size: SUCCESS (0.002s)
[91.828048] [136/171] (895s left) prime_self_import (basic-with_fd_dup)
[91.881100] Starting subtest: basic-with_fd_dup
[91.892128] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[91.930303] [137/171] (895s left) prime_self_import (basic-with_one_bo)
[91.980074] Starting subtest: basic-with_one_bo
[91.990770] Subtest basic-with_one_bo: SUCCESS (0.002s)
[92.012419] [138/171] (895s left) prime_self_import (basic-with_one_bo_two_files)
[92.079209] Starting subtest: basic-with_one_bo_two_files
[92.090834] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[92.130217] [139/171] (895s left) prime_self_import (basic-with_two_bos)
[92.186979] Starting subtest: basic-with_two_bos
[92.198275] Subtest basic-with_two_bos: SUCCESS (0.002s)
[92.245436] [140/171] (895s left) prime_vgem (basic-fence-flip)
[92.324365] Starting subtest: basic-fence-flip
[92.341896] Subtest basic-fence-flip: SKIP (0.021s)
[92.382205] [141/171] (895s left) prime_vgem (basic-fence-mmap)
[92.449686] Starting subtest: basic-fence-mmap
[92.455182] Subtest basic-fence-mmap: SUCCESS (0.015s)
[92.516536] [142/171] (895s left) prime_vgem (basic-fence-read)
[92.597856] Starting subtest: basic-fence-read
[92.609159] Subtest basic-fence-read: SKIP (0.006s)
[92.652855] [143/171] (895s left) prime_vgem (basic-gtt)
[92.718749] Starting subtest: basic-gtt
[92.724133] Subtest basic-gtt: SUCCESS (0.006s)
[92.769141] [144/171] (895s left) prime_vgem (basic-read)
[92.841921] Starting subtest: basic-read
[92.852628] Subtest basic-read: SKIP (0.003s)
[92.885450] [145/171] (895s left) prime_vgem (basic-write)
[92.950035] Starting subtest: basic-write
[92.961037] Subtest basic-write: SKIP (0.003s)
[93.006399] [146/171] (894s left) vgem_basic (setversion)
[93.066453] Starting subtest: setversion
[93.078157] Subtest setversion: SUCCESS (0.000s)
[93.103740] [147/171] (894s left) vgem_basic (create)
[93.175088] Starting subtest: create
[93.180666] Subtest create: SUCCESS (0.000s)
[93.202275] [148/171] (894s left) vgem_basic (debugfs)
[93.264539] Starting subtest: debugfs
[93.270068] Subtest debugfs: SUCCESS (0.000s)
[93.294748] [149/171] (894s left) vgem_basic (dmabuf-export)
[93.358511] Starting subtest: dmabuf-export
[93.369592] Subtest dmabuf-export: SUCCESS (0.002s)
[93.415194] [150/171] (894s left) vgem_basic (dmabuf-fence)
[93.481600] Starting subtest: dmabuf-fence
[93.487031] Subtest dmabuf-fence: SUCCESS (0.000s)
[93.511609] [151/171] (894s left) vgem_basic (dmabuf-fence-before)
[93.583048] Starting subtest: dmabuf-fence-before
[93.588609] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[93.612827] [152/171] (894s left) vgem_basic (dmabuf-mmap)
[93.669391] Starting subtest: dmabuf-mmap
[93.674790] Subtest dmabuf-mmap: SUCCESS (0.006s)
[93.696804] [153/171] (894s left) vgem_basic (mmap)
[93.751869] Starting subtest: mmap
[93.757340] Subtest mmap: SUCCESS (0.004s)
[93.779923] [154/171] (894s left) vgem_basic (second-client)
[93.840979] Starting subtest: second-client
[93.851885] Subtest second-client: SUCCESS (0.008s)
[93.873793] [155/171] (894s left) vgem_basic (sysfs)
[93.933027] Starting subtest: sysfs
[93.938519] Subtest sysfs: SUCCESS (0.000s)
[93.960342] [156/171] (894s left) core_hotunplug (unbind-rebind)
[94.024166] Starting subtest: unbind-rebind
[95.695007] Subtest unbind-rebind: SUCCESS (1.669s)
[95.729392] [157/171] (892s left) vgem_basic (unload)
[95.778198] Starting subtest: unload
[124.590959] Subtest unload: SUCCESS (28.808s)
[124.618956] [158/171] (863s left) i915_module_load (reload)
[124.664427] Starting subtest: reload
[126.961204] Subtest reload: SUCCESS (2.301s)
[126.987744] [159/171] (861s left) gem_lmem_swapping (basic)
[127.050334] Subtest basic: SKIP (0.000s)
[127.071799] [160/171] (861s left) gem_lmem_swapping (parallel-random-engines)
[127.127167] Subtest parallel-random-engines: SKIP (0.000s)
[127.152984] [161/171] (861s left) gem_lmem_swapping (random-engines)
[127.211383] Subtest random-engines: SKIP (0.000s)
[127.235089] [162/171] (861s left) gem_lmem_swapping (verify-random)
[127.296943] Subtest verify-random: SKIP (0.000s)
[127.326405] [163/171] (861s left) i915_pm_rpm (module-reload)
[128.624380] Starting subtest: module-reload
[136.074305] Subtest module-reload: SUCCESS (7.442s)
[136.105392] [164/171] (852s left) i915_selftest (live)
[136.162560] Starting subtest: live
[136.168042] Starting dynamic subtest: sanitycheck
[137.781498] Dynamic subtest sanitycheck: SUCCESS (1.612s)
[137.790926] Starting dynamic subtest: uncore
[139.404324] Dynamic subtest uncore: SUCCESS (1.621s)
[139.415416] Starting dynamic subtest: workarounds
[141.977467] Dynamic subtest workarounds: SUCCESS (2.572s)
[141.985784] Starting dynamic subtest: gt_engines
[144.164683] Dynamic subtest gt_engines: SUCCESS (2.186s)
[144.174630] Starting dynamic subtest: gt_timelines
[167.874775] Dynamic subtest gt_timelines: SUCCESS (23.709s)
[167.882839] Starting dynamic subtest: gt_contexts
[169.500964] Dynamic subtest gt_contexts: SUCCESS (1.625s)
[169.513474] Starting dynamic subtest: gt_lrc
[174.475769] Dynamic subtest gt_lrc: SUCCESS (4.974s)
[174.484017] Starting dynamic subtest: gt_mocs
[176.557297] Dynamic subtest gt_mocs: SUCCESS (2.081s)
[176.565086] Starting dynamic subtest: gt_pm
[183.207528] Dynamic subtest gt_pm: FAIL (5.303s)
[183.215623] Starting dynamic subtest: gt_heartbeat
[183.600399] Dynamic subtest gt_heartbeat: SUCCESS (1.745s)
[183.612498] Starting dynamic subtest: gt_tlb
[186.609286] Dynamic subtest gt_tlb: SUCCESS (2.999s)
[186.617373] Starting dynamic subtest: requests
[196.164582] Dynamic subtest requests: SUCCESS (9.554s)
[196.172972] Starting dynamic subtest: migrate
[200.552664] Dynamic subtest migrate: SUCCESS (4.387s)
[200.560903] Starting dynamic subtest: active
[202.128766] Dynamic subtest active: SUCCESS (1.575s)
[202.137730] Starting dynamic subtest: objects
[204.102874] Dynamic subtest objects: SUCCESS (1.973s)
[204.110949] Starting dynamic subtest: mman
[209.261817] Dynamic subtest mman: SUCCESS (5.158s)
[209.270467] Starting dynamic subtest: dmabuf
[210.907828] Dynamic subtest dmabuf: SUCCESS (1.645s)
[210.916356] Starting dynamic subtest: vma
[212.546644] Dynamic subtest vma: SUCCESS (1.637s)
[212.554641] Starting dynamic subtest: coherency
[222.353893] Dynamic subtest coherency: SUCCESS (9.806s)
[222.362283] Starting dynamic subtest: gtt
[231.415616] Dynamic subtest gtt: SUCCESS (9.061s)
[231.424091] Starting dynamic subtest: gem
[233.158025] Dynamic subtest gem: SUCCESS (1.741s)
[233.166307] Starting dynamic subtest: evict
[238.816458] Dynamic subtest evict: SUCCESS (5.657s)
[238.824724] Starting dynamic subtest: hugepages
[246.976502] Dynamic subtest hugepages: SUCCESS (8.159s)
[246.984826] Starting dynamic subtest: gem_contexts
[268.454679] Dynamic subtest gem_contexts: SUCCESS (21.477s)
[268.463681] Starting dynamic subtest: client
[270.081956] Dynamic subtest client: SUCCESS (1.627s)
[270.090672] Starting dynamic subtest: gem_migrate
[271.664671] Dynamic subtest gem_migrate: SUCCESS (1.581s)
[271.672838] Starting dynamic subtest: reset
[276.829958] Dynamic subtest reset: SUCCESS (5.164s)
[276.838102] Starting dynamic subtest: memory_region
[278.411670] Dynamic subtest memory_region: SUCCESS (1.580s)
[278.425064] Starting dynamic subtest: hangcheck
[298.843186] Dynamic subtest hangcheck: SUCCESS (20.430s)
[298.851569] Starting dynamic subtest: execlists
[300.445090] Dynamic subtest execlists: SUCCESS (1.601s)
[300.453354] Starting dynamic subtest: ring_submission
[302.041502] Dynamic subtest ring_submission: SUCCESS (1.595s)
[302.049694] Starting dynamic subtest: perf
[303.745566] Dynamic subtest perf: SUCCESS (1.703s)
[303.753738] Starting dynamic subtest: slpc
[310.651855] Dynamic subtest slpc: SUCCESS (6.905s)
[310.661819] Starting dynamic subtest: guc
[313.557520] Dynamic subtest guc: SUCCESS (2.904s)
[313.565754] Starting dynamic subtest: guc_multi_lrc
[315.195452] Dynamic subtest guc_multi_lrc: SUCCESS (1.637s)
[315.203468] Starting dynamic subtest: guc_hang
[317.449508] Dynamic subtest guc_hang: SUCCESS (2.253s)
[317.457882] Starting dynamic subtest: late_gt_pm
[319.097379] Dynamic subtest late_gt_pm: SUCCESS (1.647s)
[319.103504] Subtest live: FAIL (182.929s)
[319.274639] [165/171] (669s left) dmabuf (all-tests)
[319.333570] Starting subtest: all-tests
[319.339135] Starting dynamic subtest: sanitycheck
[319.401184] Dynamic subtest sanitycheck: SUCCESS (0.071s)
[319.415834] Starting dynamic subtest: dma_fence
[319.580117] Dynamic subtest dma_fence: SUCCESS (0.178s)
[319.589054] Starting dynamic subtest: dma_fence_chain
[328.298611] Dynamic subtest dma_fence_chain: SUCCESS (8.717s)
[328.309277] Starting dynamic subtest: dma_fence_unwrap
[328.370439] Dynamic subtest dma_fence_unwrap: SUCCESS (0.071s)
[328.383095] Starting dynamic subtest: dma_resv
[328.445494] Dynamic subtest dma_resv: SUCCESS (0.074s)
[328.451264] Subtest all-tests: SUCCESS (9.116s)
[328.479255] [166/171] (660s left) i915_suspend (basic-s2idle-without-i915)
[328.546706] Starting subtest: basic-s2idle-without-i915
[351.498827] Subtest basic-s2idle-without-i915: SUCCESS (9.743s)
[351.527357] [167/171] (650s left) i915_suspend (basic-s3-without-i915)
[351.577031] Starting subtest: basic-s3-without-i915
[376.928005] Subtest basic-s3-without-i915: SUCCESS (9.721s)
[376.984610] [168/171] (640s left) gem_exec_suspend (basic-s0)
[377.040012] Starting subtest: basic-S0
[377.045576] Starting dynamic subtest: smem
[399.546865] Dynamic subtest smem: SUCCESS (8.066s)
[399.552491] Subtest basic-S0: SUCCESS (8.067s)
[399.699426] [169/171] (632s left) gem_exec_suspend (basic-s3)
[399.765974] Starting subtest: basic-S3
[399.771505] Starting dynamic subtest: smem
[427.949531] Dynamic subtest smem: SUCCESS (12.567s)
[427.955783] Subtest basic-S3: SUCCESS (12.568s)
[436.116165] [170/171] (619s left) kms_chamelium_hpd (common-hpd-after-suspend)
[436.201822] Subtest common-hpd-after-suspend: SKIP (0.000s)
[436.224635] [171/171] (619s left) kms_pipe_crc_basic (suspend-read-crc)
[436.304605] Subtest suspend-read-crc: SKIP (0.000s)
[436.321810] Closing watchdogs
Done.