[38.399291] Initializing watchdogs
[38.399374]   /dev/watchdog0
[38.404447] [001/171] (960s left) i915_module_load (load)
[38.476269] Starting subtest: load
[39.329706] Subtest load: SUCCESS (0.853s)
[39.344859] [002/171] (959s left) core_auth (basic-auth)
[39.490040] Starting subtest: basic-auth
[39.490614] Subtest basic-auth: SUCCESS (0.001s)
[39.502108] [003/171] (959s left) debugfs_test (read_all_entries)
[39.575236] Starting subtest: read_all_entries
[39.699388] Subtest read_all_entries: SUCCESS (0.124s)
[39.733055] [004/171] (959s left) debugfs_test (basic-hwmon)
[39.803837] Starting subtest: basic-hwmon
[39.804931] Subtest basic-hwmon: SKIP (0.000s)
[39.857426] [005/171] (959s left) fbdev (eof)
[41.030594] Subtest eof: SKIP (0.000s)
[41.040607] [006/171] (957s left) fbdev (info)
[41.114581] Subtest info: SKIP (0.000s)
[41.125704] [007/171] (957s left) fbdev (nullptr)
[41.200732] Subtest nullptr: SKIP (0.000s)
[41.211257] [008/171] (957s left) fbdev (read)
[41.285972] Subtest read: SKIP (0.000s)
[41.295967] [009/171] (957s left) fbdev (write)
[41.372699] Subtest write: SKIP (0.000s)
[41.383107] [010/171] (957s left) gem_basic (bad-close)
[41.450920] Starting subtest: bad-close
[41.452154] Subtest bad-close: SUCCESS (0.000s)
[41.461414] [011/171] (957s left) gem_basic (create-close)
[41.527975] Starting subtest: create-close
[41.529108] Subtest create-close: SUCCESS (0.000s)
[41.555396] [012/171] (957s left) gem_basic (create-fd-close)
[41.624067] Starting subtest: create-fd-close
[41.625108] Subtest create-fd-close: SUCCESS (0.000s)
[41.645216] [013/171] (957s left) gem_busy (busy@all-engines)
[41.722983] Starting subtest: busy
[41.723631] Starting dynamic subtest: all-engines
[41.751992] Dynamic subtest all-engines: SUCCESS (0.029s)
[41.752542] Subtest busy: SUCCESS (0.029s)
[42.145529] [014/171] (956s left) gem_close_race (basic-process)
[42.260911] Starting subtest: basic-process
[42.313030] Subtest basic-process: SUCCESS (0.052s)
[42.456433] [015/171] (956s left) gem_close_race (basic-threads)
[42.532673] Starting subtest: basic-threads
[43.742028] Subtest basic-threads: SUCCESS (1.209s)
[43.919782] [016/171] (955s left) gem_ctx_create (basic)
[44.019528] Starting subtest: basic
[44.020029] Subtest basic: SUCCESS (0.000s)
[44.164878] [017/171] (954s left) gem_ctx_create (basic-files)
[44.265463] Starting subtest: basic-files
[46.278680] Subtest basic-files: SUCCESS (2.013s)
[46.484277] [018/171] (952s left) gem_ctx_exec (basic)
[46.593823] Starting subtest: basic
[46.597721] Subtest basic: SUCCESS (0.004s)
[46.639897] [019/171] (952s left) gem_exec_basic (basic)
[46.716634] Starting subtest: basic
[46.717313] Starting dynamic subtest: rcs0-smem
[46.717843] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[46.722174] Starting dynamic subtest: bcs0-smem
[46.722805] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[46.726861] Starting dynamic subtest: vcs0-smem
[46.727462] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[46.731569] Starting dynamic subtest: vecs0-smem
[46.732026] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[46.732555] Subtest basic: SUCCESS (0.004s)
[46.880233] [020/171] (952s left) gem_exec_create (basic)
[46.982071] Starting subtest: basic
[46.982607] Starting dynamic subtest: smem
[49.022846] Dynamic subtest smem: SUCCESS (2.041s)
[49.023344] Subtest basic: SUCCESS (2.041s)
[49.174562] [021/171] (950s left) gem_exec_fence (basic-busy)
[49.414660] Starting subtest: basic-busy
[49.415906] Starting dynamic subtest: rcs0
[49.445763] Dynamic subtest rcs0: SUCCESS (0.032s)
[49.451275] Starting dynamic subtest: bcs0
[49.480977] Dynamic subtest bcs0: SUCCESS (0.034s)
[49.487036] Starting dynamic subtest: vcs0
[49.503950] Dynamic subtest vcs0: SUCCESS (0.024s)
[49.510721] Starting dynamic subtest: vecs0
[49.533977] Dynamic subtest vecs0: SUCCESS (0.030s)
[49.534945] Subtest basic-busy: SUCCESS (0.121s)
[50.108079] [022/171] (949s left) gem_exec_fence (basic-wait)
[50.337860] Starting subtest: basic-wait
[50.338966] Starting dynamic subtest: rcs0
[50.371973] Dynamic subtest rcs0: SUCCESS (0.034s)
[50.376827] Starting dynamic subtest: bcs0
[50.405971] Dynamic subtest bcs0: SUCCESS (0.033s)
[50.412946] Starting dynamic subtest: vcs0
[50.438356] Dynamic subtest vcs0: SUCCESS (0.032s)
[50.461068] Starting dynamic subtest: vecs0
[50.483524] Dynamic subtest vecs0: SUCCESS (0.045s)
[50.485722] Subtest basic-wait: SUCCESS (0.145s)
[51.001234] [023/171] (948s left) gem_exec_fence (basic-await)
[51.254819] Starting subtest: basic-await
[51.256259] Starting dynamic subtest: rcs0
[51.344035] Dynamic subtest rcs0: SUCCESS (0.088s)
[51.350131] Starting dynamic subtest: bcs0
[51.426689] Dynamic subtest bcs0: SUCCESS (0.082s)
[51.436880] Starting dynamic subtest: vcs0
[51.521827] Dynamic subtest vcs0: SUCCESS (0.095s)
[51.529599] Starting dynamic subtest: vecs0
[51.611514] Dynamic subtest vecs0: SUCCESS (0.088s)
[51.612294] Subtest basic-await: SUCCESS (0.355s)
[52.168810] [024/171] (947s left) gem_exec_fence (nb-await)
[52.398068] Starting subtest: nb-await
[52.398920] Starting dynamic subtest: rcs0
[52.461334] Dynamic subtest rcs0: SUCCESS (0.060s)
[52.473200] Starting dynamic subtest: bcs0
[52.531334] Dynamic subtest bcs0: SUCCESS (0.070s)
[52.553342] Starting dynamic subtest: vcs0
[52.611869] Dynamic subtest vcs0: SUCCESS (0.080s)
[52.634832] Starting dynamic subtest: vecs0
[52.691897] Dynamic subtest vecs0: SUCCESS (0.080s)
[52.694108] Subtest nb-await: SUCCESS (0.292s)
[53.285232] [025/171] (946s left) gem_exec_gttfill (basic)
[53.373040] Starting subtest: basic
[56.745040] Subtest basic: SUCCESS (3.372s)
[56.867072] [026/171] (942s left) gem_exec_parallel (engines)
[57.008996] Starting subtest: engines
[57.009537] Starting dynamic subtest: basic
[58.712472] Dynamic subtest basic: SUCCESS (1.703s)
[58.717491] Starting dynamic subtest: contexts
[61.764987] Dynamic subtest contexts: SUCCESS (3.046s)
[61.770041] Starting dynamic subtest: fds
[64.202984] Dynamic subtest fds: SUCCESS (2.444s)
[64.208887] Starting dynamic subtest: userptr
[66.138901] Dynamic subtest userptr: SUCCESS (1.936s)
[66.139521] Subtest engines: SUCCESS (9.130s)
[66.331582] [027/171] (933s left) gem_exec_store (basic)
[66.410348] Starting subtest: basic
[66.457943] Subtest basic: SUCCESS (0.048s)
[66.614669] [028/171] (932s left) gem_flink_basic (bad-flink)
[66.700199] Starting subtest: bad-flink
[66.700682] Subtest bad-flink: SUCCESS (0.000s)
[66.712138] [029/171] (932s left) gem_flink_basic (bad-open)
[66.778288] Starting subtest: bad-open
[66.778813] Subtest bad-open: SUCCESS (0.000s)
[66.790165] [030/171] (932s left) gem_flink_basic (basic)
[66.856219] Starting subtest: basic
[66.856871] Subtest basic: SUCCESS (0.000s)
[66.886109] [031/171] (932s left) gem_flink_basic (double-flink)
[66.955270] Starting subtest: double-flink
[66.955727] Subtest double-flink: SUCCESS (0.000s)
[66.986034] [032/171] (932s left) gem_flink_basic (flink-lifetime)
[67.054509] Starting subtest: flink-lifetime
[67.054928] Subtest flink-lifetime: SUCCESS (0.001s)
[67.086986] [033/171] (932s left) gem_huc_copy (huc-copy)
[67.162423] Starting subtest: huc-copy
[67.164615] Subtest huc-copy: SUCCESS (0.002s)
[67.207639] [034/171] (932s left) gem_linear_blits (basic)
[67.370268] Starting subtest: basic
[67.374781] Subtest basic: SUCCESS (0.005s)
[67.475893] [035/171] (932s left) gem_mmap (basic)
[67.656136] Starting subtest: basic
[67.658075] Subtest basic: SUCCESS (0.000s)
[67.692676] [036/171] (931s left) gem_mmap_gtt (basic)
[67.765659] Starting subtest: basic
[67.766243] Subtest basic: SUCCESS (0.000s)
[67.778128] [037/171] (931s left) gem_render_linear_blits (basic)
[67.848985] Starting subtest: basic
[67.873359] Subtest basic: SUCCESS (0.024s)
[67.896099] [038/171] (931s left) gem_render_tiled_blits (basic)
[67.965139] Starting subtest: basic
[68.002980] Subtest basic: SUCCESS (0.037s)
[68.035337] [039/171] (931s left) gem_ringfill (basic-all)
[68.273161] Starting subtest: basic-all
[69.406721] Subtest basic-all: SUCCESS (1.131s)
[69.450494] [040/171] (930s left) gem_softpin (allocator-basic)
[69.530642] Starting subtest: allocator-basic
[69.624859] Subtest allocator-basic: SUCCESS (0.091s)
[69.669474] [041/171] (929s left) gem_softpin (allocator-basic-reserve)
[69.739875] Starting subtest: allocator-basic-reserve
[69.829622] Subtest allocator-basic-reserve: SUCCESS (0.086s)
[69.872440] [042/171] (929s left) gem_softpin (safe-alignment)
[69.944480] Starting subtest: safe-alignment
[69.954459] Subtest safe-alignment: SUCCESS (0.010s)
[69.994348] [043/171] (929s left) gem_sync (basic-all)
[70.077219] Starting subtest: basic-all
[72.131833] Subtest basic-all: SUCCESS (2.055s)
[72.255514] [044/171] (927s left) gem_sync (basic-each)
[72.339655] Starting subtest: basic-each
[74.429951] Subtest basic-each: SUCCESS (2.090s)
[74.601889] [045/171] (925s left) gem_tiled_blits (basic)
[74.821453] Starting subtest: basic
[74.836576] Subtest basic: SUCCESS (0.015s)
[74.907052] [046/171] (924s left) gem_tiled_fence_blits (basic)
[75.183461] Starting subtest: basic
[75.191282] Subtest basic: SUCCESS (0.009s)
[75.250266] [047/171] (924s left) gem_tiled_pread_basic
[75.494616] [048/171] (924s left) gem_wait (busy@all-engines)
[75.576428] Starting subtest: busy
[75.576879] Starting dynamic subtest: all-engines
[76.092816] Dynamic subtest all-engines: SUCCESS (0.518s)
[76.093304] Subtest busy: SUCCESS (0.518s)
[76.230458] [049/171] (923s left) gem_wait (wait@all-engines)
[76.315162] Starting subtest: wait
[76.315723] Starting dynamic subtest: all-engines
[77.349745] Dynamic subtest all-engines: SUCCESS (1.034s)
[77.350301] Subtest wait: SUCCESS (1.035s)
[77.489173] [050/171] (922s left) i915_getparams_basic (basic-eu-total)
[77.559465] Starting subtest: basic-eu-total
[77.560507] Subtest basic-eu-total: SUCCESS (0.000s)
[77.571572] [051/171] (922s left) i915_getparams_basic (basic-subslice-total)
[77.638713] Starting subtest: basic-subslice-total
[77.639751] Subtest basic-subslice-total: SUCCESS (0.000s)
[77.651806] [052/171] (922s left) i915_hangman (error-state-basic)
[77.731745] Starting subtest: error-state-basic
[77.792111] Subtest error-state-basic: SUCCESS (0.061s)
[77.806053] [053/171] (921s left) i915_pciid
[77.885298] [054/171] (921s left) kms_addfb_basic (addfb25-bad-modifier)
[77.953650] Starting subtest: addfb25-bad-modifier
[77.954421] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[78.060606] [055/171] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[78.126998] Starting subtest: addfb25-framebuffer-vs-set-tiling
[78.127564] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[78.236629] [056/171] (921s left) kms_addfb_basic (addfb25-modifier-no-flag)
[78.305216] Starting subtest: addfb25-modifier-no-flag
[78.305729] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[78.406776] [057/171] (921s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[78.474141] Starting subtest: addfb25-x-tiled-legacy
[78.474667] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[78.582478] [058/171] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[78.652943] Starting subtest: addfb25-x-tiled-mismatch-legacy
[78.653447] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[78.749532] [059/171] (921s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[78.892092] Starting subtest: addfb25-yf-tiled-legacy
[78.892547] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[78.921487] [060/171] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[79.063851] Starting subtest: addfb25-y-tiled-legacy
[79.064304] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[79.092501] [061/171] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[79.244174] Starting subtest: addfb25-y-tiled-small-legacy
[79.246586] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[79.279668] [062/171] (920s left) kms_addfb_basic (bad-pitch-0)
[79.347415] Starting subtest: bad-pitch-0
[79.347933] Subtest bad-pitch-0: SUCCESS (0.000s)
[79.456848] [063/171] (920s left) kms_addfb_basic (bad-pitch-1024)
[79.523695] Starting subtest: bad-pitch-1024
[79.524181] Subtest bad-pitch-1024: SUCCESS (0.000s)
[79.625370] [064/171] (920s left) kms_addfb_basic (bad-pitch-128)
[79.692613] Starting subtest: bad-pitch-128
[79.693117] Subtest bad-pitch-128: SUCCESS (0.000s)
[79.796738] [065/171] (920s left) kms_addfb_basic (bad-pitch-256)
[79.863139] Starting subtest: bad-pitch-256
[79.863722] Subtest bad-pitch-256: SUCCESS (0.000s)
[79.966636] [066/171] (919s left) kms_addfb_basic (bad-pitch-32)
[80.032080] Starting subtest: bad-pitch-32
[80.032568] Subtest bad-pitch-32: SUCCESS (0.000s)
[80.139457] [067/171] (919s left) kms_addfb_basic (bad-pitch-63)
[80.207589] Starting subtest: bad-pitch-63
[80.208009] Subtest bad-pitch-63: SUCCESS (0.000s)
[80.312085] [068/171] (919s left) kms_addfb_basic (bad-pitch-65536)
[80.380335] Starting subtest: bad-pitch-65536
[80.380825] Subtest bad-pitch-65536: SUCCESS (0.000s)
[80.480097] [069/171] (919s left) kms_addfb_basic (bad-pitch-999)
[80.547689] Starting subtest: bad-pitch-999
[80.548329] Subtest bad-pitch-999: SUCCESS (0.000s)
[80.654841] [070/171] (919s left) kms_addfb_basic (basic)
[80.721978] Starting subtest: basic
[80.722529] Subtest basic: SUCCESS (0.000s)
[80.828017] [071/171] (919s left) kms_addfb_basic (basic-x-tiled-legacy)
[80.896623] Starting subtest: basic-x-tiled-legacy
[80.897084] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[81.006032] [072/171] (919s left) kms_addfb_basic (basic-y-tiled-legacy)
[81.073229] Starting subtest: basic-y-tiled-legacy
[81.073838] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[81.172659] [073/171] (918s left) kms_addfb_basic (bo-too-small)
[81.314452] Starting subtest: bo-too-small
[81.314884] Subtest bo-too-small: SUCCESS (0.000s)
[81.345294] [074/171] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[81.486726] Starting subtest: bo-too-small-due-to-tiling
[81.487247] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[81.521422] [075/171] (918s left) kms_addfb_basic (clobberred-modifier)
[81.588655] Starting subtest: clobberred-modifier
[81.589132] Subtest clobberred-modifier: SUCCESS (0.000s)
[81.692507] [076/171] (918s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[81.760458] Starting subtest: framebuffer-vs-set-tiling
[81.760836] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[81.855438] [077/171] (918s left) kms_addfb_basic (invalid-get-prop)
[81.922312] Starting subtest: invalid-get-prop
[81.922842] Subtest invalid-get-prop: SUCCESS (0.000s)
[82.027747] [078/171] (918s left) kms_addfb_basic (invalid-get-prop-any)
[82.095441] Starting subtest: invalid-get-prop-any
[82.095840] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[82.194635] [079/171] (917s left) kms_addfb_basic (invalid-set-prop)
[82.263287] Starting subtest: invalid-set-prop
[82.263839] Subtest invalid-set-prop: SUCCESS (0.000s)
[82.371335] [080/171] (917s left) kms_addfb_basic (invalid-set-prop-any)
[82.437664] Starting subtest: invalid-set-prop-any
[82.438079] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[82.535914] [081/171] (917s left) kms_addfb_basic (no-handle)
[82.603797] Starting subtest: no-handle
[82.604201] Subtest no-handle: SUCCESS (0.000s)
[82.704617] [082/171] (917s left) kms_addfb_basic (size-max)
[82.845610] Starting subtest: size-max
[82.846041] Subtest size-max: SUCCESS (0.000s)
[82.881056] [083/171] (917s left) kms_addfb_basic (small-bo)
[83.022388] Starting subtest: small-bo
[83.022873] Subtest small-bo: SUCCESS (0.000s)
[83.051198] [084/171] (917s left) kms_addfb_basic (tile-pitch-mismatch)
[83.118190] Starting subtest: tile-pitch-mismatch
[83.118749] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[83.216059] [085/171] (916s left) kms_addfb_basic (too-high)
[83.364643] Starting subtest: too-high
[83.365139] Subtest too-high: SUCCESS (0.000s)
[83.400473] [086/171] (916s left) kms_addfb_basic (too-wide)
[83.543599] Starting subtest: too-wide
[83.544032] Subtest too-wide: SUCCESS (0.000s)
[83.573439] [087/171] (916s left) kms_addfb_basic (unused-handle)
[83.640571] Starting subtest: unused-handle
[83.641042] Subtest unused-handle: SUCCESS (0.000s)
[83.732523] [088/171] (916s left) kms_addfb_basic (unused-modifier)
[83.799504] Starting subtest: unused-modifier
[83.799932] Subtest unused-modifier: SUCCESS (0.000s)
[83.904731] [089/171] (916s left) kms_addfb_basic (unused-offsets)
[83.971988] Starting subtest: unused-offsets
[83.972482] Subtest unused-offsets: SUCCESS (0.000s)
[84.080430] [090/171] (916s left) kms_addfb_basic (unused-pitches)
[84.146278] Starting subtest: unused-pitches
[84.146818] Subtest unused-pitches: SUCCESS (0.000s)
[84.251895] [091/171] (916s left) kms_busy (basic)
[84.434661] Subtest basic: SKIP (0.000s)
[84.446273] [092/171] (915s left) kms_chamelium_hpd (dp-hpd-fast)
[84.593999] Subtest dp-hpd-fast: SKIP (0.000s)
[84.606106] [093/171] (915s left) kms_chamelium_edid (dp-edid-read)
[84.750898] Subtest dp-edid-read: SKIP (0.000s)
[84.763912] [094/171] (915s left) kms_chamelium_frames (dp-crc-fast)
[84.908890] Subtest dp-crc-fast: SKIP (0.000s)
[84.920732] [095/171] (915s left) kms_chamelium_hpd (hdmi-hpd-fast)
[85.066728] Subtest hdmi-hpd-fast: SKIP (0.000s)
[85.077112] [096/171] (915s left) kms_chamelium_edid (hdmi-edid-read)
[85.224219] Subtest hdmi-edid-read: SKIP (0.000s)
[85.235963] [097/171] (915s left) kms_chamelium_frames (hdmi-crc-fast)
[85.380666] Subtest hdmi-crc-fast: SKIP (0.000s)
[85.392363] [098/171] (914s left) kms_chamelium_hpd (vga-hpd-fast)
[85.537576] Subtest vga-hpd-fast: SKIP (0.000s)
[85.549054] [099/171] (914s left) kms_chamelium_edid (vga-edid-read)
[85.693728] Subtest vga-edid-read: SKIP (0.000s)
[85.705361] [100/171] (914s left) kms_prop_blob (basic)
[85.772168] Starting subtest: basic
[85.772698] Subtest basic: SUCCESS (0.000s)
[85.784272] [101/171] (914s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[85.927955] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[85.936370] [102/171] (914s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[86.080715] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[86.088810] [103/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[86.231218] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[86.240488] [104/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[86.384916] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[86.394129] [105/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[86.537686] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[86.546199] [106/171] (913s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[86.689732] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[86.698413] [107/171] (913s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[86.844040] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[86.853178] [108/171] (913s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[86.997013] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[87.006393] [109/171] (913s left) kms_flip (basic-flip-vs-dpms)
[87.110690] Starting subtest: basic-flip-vs-dpms
[87.111449] Subtest basic-flip-vs-dpms: SKIP (0.001s)
[87.150747] [110/171] (913s left) kms_flip (basic-flip-vs-modeset)
[87.256043] Starting subtest: basic-flip-vs-modeset
[87.257746] Subtest basic-flip-vs-modeset: SKIP (0.002s)
[87.280170] [111/171] (913s left) kms_flip (basic-flip-vs-wf_vblank)
[87.382833] Starting subtest: basic-flip-vs-wf_vblank
[87.384245] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s)
[87.405916] [112/171] (913s left) kms_flip (basic-plain-flip)
[87.509304] Starting subtest: basic-plain-flip
[87.510999] Subtest basic-plain-flip: SKIP (0.001s)
[87.547399] [113/171] (912s left) kms_force_connector_basic (force-connector-state)
[87.699265] Starting subtest: force-connector-state
[87.986058] Subtest force-connector-state: SUCCESS (0.287s)
[88.216097] [114/171] (912s left) kms_force_connector_basic (force-edid)
[88.367759] Starting subtest: force-edid
[88.459162] Subtest force-edid: SUCCESS (0.092s)
[88.652845] [115/171] (911s left) kms_force_connector_basic (force-load-detect)
[88.804530] Starting subtest: force-load-detect
[88.806061] Subtest force-load-detect: SKIP (0.000s)
[88.960942] [116/171] (911s left) kms_force_connector_basic (prune-stale-modes)
[89.115444] Starting subtest: prune-stale-modes
[89.205977] Subtest prune-stale-modes: SUCCESS (0.091s)
[89.398820] [117/171] (911s left) kms_frontbuffer_tracking (basic)
[89.541963] Subtest basic: SKIP (0.000s)
[89.572200] [118/171] (911s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[89.712213] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[89.727670] [119/171] (910s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[89.872955] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[89.887329] [120/171] (910s left) kms_pipe_crc_basic (hang-read-crc)
[90.028154] Subtest hang-read-crc: SKIP (0.000s)
[90.043866] [121/171] (910s left) kms_pipe_crc_basic (nonblocking-crc)
[90.191230] Subtest nonblocking-crc: SKIP (0.000s)
[90.207918] [122/171] (910s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[90.351482] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[90.369035] [123/171] (910s left) kms_pipe_crc_basic (read-crc)
[90.510952] Subtest read-crc: SKIP (0.000s)
[90.527402] [124/171] (910s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[90.667902] Subtest read-crc-frame-sequence: SKIP (0.000s)
[90.686212] [125/171] (910s left) kms_psr (primary_page_flip)
[90.753540] Subtest primary_page_flip: SKIP (0.000s)
[90.770988] [126/171] (909s left) kms_psr (cursor_plane_move)
[90.838972] Subtest cursor_plane_move: SKIP (0.000s)
[90.855855] [127/171] (909s left) kms_psr (sprite_plane_onoff)
[90.924491] Subtest sprite_plane_onoff: SKIP (0.000s)
[90.942172] [128/171] (909s left) kms_psr (primary_mmap_gtt)
[91.011921] Subtest primary_mmap_gtt: SKIP (0.000s)
[91.026962] [129/171] (909s left) kms_setmode (basic-clone-single-crtc)
[91.094031] Starting subtest: basic-clone-single-crtc
[91.096577] Subtest basic-clone-single-crtc: SKIP (0.000s)
[91.116046] [130/171] (909s left) i915_pm_backlight (basic-brightness)
[91.267904] Subtest basic-brightness: SKIP (0.000s)
[91.285927] [131/171] (909s left) i915_pm_rpm (basic-pci-d3-state)
[103.233590] Subtest basic-pci-d3-state: SKIP (0.000s)
[103.459255] [132/171] (897s left) i915_pm_rpm (basic-rte)
[103.527646] Starting subtest: basic-rte
[115.433443] Subtest basic-rte: FAIL (11.883s)
[126.406899] [133/171] (874s left) i915_pm_rps (basic-api)
[126.485410] Starting subtest: basic-api
[126.487749] Subtest basic-api: SUCCESS (0.003s)
[126.504358] [134/171] (874s left) prime_self_import (basic-llseek-bad)
[126.569814] Starting subtest: basic-llseek-bad
[126.571547] Subtest basic-llseek-bad: SUCCESS (0.001s)
[126.623818] [135/171] (874s left) prime_self_import (basic-llseek-size)
[126.696299] Starting subtest: basic-llseek-size
[126.698232] Subtest basic-llseek-size: SUCCESS (0.002s)
[126.734265] [136/171] (874s left) prime_self_import (basic-with_fd_dup)
[126.802469] Starting subtest: basic-with_fd_dup
[126.804938] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[126.855118] [137/171] (874s left) prime_self_import (basic-with_one_bo)
[126.922591] Starting subtest: basic-with_one_bo
[126.924898] Subtest basic-with_one_bo: SUCCESS (0.002s)
[126.950339] [138/171] (873s left) prime_self_import (basic-with_one_bo_two_files)
[127.017666] Starting subtest: basic-with_one_bo_two_files
[127.019763] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[127.066387] [139/171] (873s left) prime_self_import (basic-with_two_bos)
[127.133238] Starting subtest: basic-with_two_bos
[127.135626] Subtest basic-with_two_bos: SUCCESS (0.002s)
[127.182413] [140/171] (873s left) prime_vgem (basic-fence-flip)
[127.257308] Starting subtest: basic-fence-flip
[127.321318] Subtest basic-fence-flip: SKIP (0.063s)
[127.348793] [141/171] (873s left) prime_vgem (basic-fence-mmap)
[127.427054] Starting subtest: basic-fence-mmap
[127.450654] Subtest basic-fence-mmap: SUCCESS (0.023s)
[127.499326] [142/171] (873s left) prime_vgem (basic-fence-read)
[127.579822] Starting subtest: basic-fence-read
[127.616208] Subtest basic-fence-read: SUCCESS (0.035s)
[127.664928] [143/171] (873s left) prime_vgem (basic-gtt)
[127.746794] Starting subtest: basic-gtt
[127.756701] Subtest basic-gtt: SUCCESS (0.010s)
[127.789915] [144/171] (873s left) prime_vgem (basic-read)
[127.863809] Starting subtest: basic-read
[127.879660] Subtest basic-read: SUCCESS (0.016s)
[127.908046] [145/171] (873s left) prime_vgem (basic-write)
[127.983491] Starting subtest: basic-write
[128.005934] Subtest basic-write: SUCCESS (0.021s)
[128.025329] [146/171] (872s left) vgem_basic (setversion)
[128.094183] Starting subtest: setversion
[128.095408] Subtest setversion: SUCCESS (0.000s)
[128.115451] [147/171] (872s left) vgem_basic (create)
[128.185245] Starting subtest: create
[128.185705] Subtest create: SUCCESS (0.000s)
[128.207295] [148/171] (872s left) vgem_basic (debugfs)
[128.276601] Starting subtest: debugfs
[128.277038] Subtest debugfs: SUCCESS (0.000s)
[128.298667] [149/171] (872s left) vgem_basic (dmabuf-export)
[128.370031] Starting subtest: dmabuf-export
[128.371674] Subtest dmabuf-export: SUCCESS (0.001s)
[128.412545] [150/171] (872s left) vgem_basic (dmabuf-fence)
[128.483022] Starting subtest: dmabuf-fence
[128.483533] Subtest dmabuf-fence: SUCCESS (0.000s)
[128.502344] [151/171] (872s left) vgem_basic (dmabuf-fence-before)
[128.568988] Starting subtest: dmabuf-fence-before
[128.569454] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[128.590925] [152/171] (872s left) vgem_basic (dmabuf-mmap)
[128.660522] Starting subtest: dmabuf-mmap
[128.671933] Subtest dmabuf-mmap: SUCCESS (0.012s)
[128.692676] [153/171] (872s left) vgem_basic (mmap)
[128.763261] Starting subtest: mmap
[128.769909] Subtest mmap: SUCCESS (0.008s)
[128.791052] [154/171] (872s left) vgem_basic (second-client)
[128.862486] Starting subtest: second-client
[128.867736] Subtest second-client: SUCCESS (0.006s)
[128.888374] [155/171] (872s left) vgem_basic (sysfs)
[128.960452] Starting subtest: sysfs
[128.960933] Subtest sysfs: SUCCESS (0.000s)
[128.982522] [156/171] (872s left) core_hotunplug (unbind-rebind)
[129.084465] Starting subtest: unbind-rebind
[129.747468] Subtest unbind-rebind: SUCCESS (0.663s)
[129.765282] [157/171] (871s left) vgem_basic (unload)
[129.861194] Starting subtest: unload
[158.721356] Subtest unload: SUCCESS (28.855s)
[158.748800] [158/171] (842s left) i915_module_load (reload)
[158.814370] Starting subtest: reload
[160.478572] Subtest reload: SUCCESS (1.664s)
[160.494529] [159/171] (840s left) gem_lmem_swapping (basic)
[160.614627] Subtest basic: SKIP (0.000s)
[160.627886] [160/171] (840s left) gem_lmem_swapping (parallel-random-engines)
[160.699330] Subtest parallel-random-engines: SKIP (0.000s)
[160.711898] [161/171] (840s left) gem_lmem_swapping (random-engines)
[160.784134] Subtest random-engines: SKIP (0.000s)
[160.796195] [162/171] (840s left) gem_lmem_swapping (verify-random)
[160.868138] Subtest verify-random: SKIP (0.000s)
[160.880350] [163/171] (840s left) i915_pm_rpm (module-reload)
[172.547430] Subtest module-reload: SKIP (0.000s)
[172.767209] [164/171] (828s left) i915_selftest (live)
[173.489085] Starting subtest: live
[173.491193] Starting dynamic subtest: sanitycheck
[174.123838] Dynamic subtest sanitycheck: SUCCESS (0.634s)
[174.128337] Starting dynamic subtest: uncore
[174.674944] Dynamic subtest uncore: SUCCESS (0.550s)
[174.680230] Starting dynamic subtest: workarounds
[175.389262] Dynamic subtest workarounds: SUCCESS (0.713s)
[175.393749] Starting dynamic subtest: gt_engines
[176.422399] Dynamic subtest gt_engines: SUCCESS (1.032s)
[176.427102] Starting dynamic subtest: gt_timelines
[184.207679] Dynamic subtest gt_timelines: SUCCESS (7.785s)
[184.212523] Starting dynamic subtest: gt_contexts
[184.845310] Dynamic subtest gt_contexts: SUCCESS (0.637s)
[184.849694] Starting dynamic subtest: gt_lrc
[187.747400] Dynamic subtest gt_lrc: SUCCESS (2.901s)
[187.752037] Starting dynamic subtest: gt_mocs
[188.391553] Dynamic subtest gt_mocs: SUCCESS (0.643s)
[188.396761] Starting dynamic subtest: gt_pm
[190.780845] Dynamic subtest gt_pm: SUCCESS (2.388s)
[190.785195] Starting dynamic subtest: gt_heartbeat
[191.430516] Dynamic subtest gt_heartbeat: SUCCESS (0.649s)
[191.435316] Starting dynamic subtest: gt_tlb
[192.827495] Dynamic subtest gt_tlb: SUCCESS (1.395s)
[192.832106] Starting dynamic subtest: requests
[199.678300] Dynamic subtest requests: SUCCESS (6.850s)
[199.682906] Starting dynamic subtest: migrate
[202.972886] Dynamic subtest migrate: SUCCESS (3.294s)
[202.977730] Starting dynamic subtest: active
[203.540593] Dynamic subtest active: SUCCESS (0.568s)
[203.545705] Starting dynamic subtest: objects
[204.936449] Dynamic subtest objects: SUCCESS (1.393s)
[204.941048] Starting dynamic subtest: mman
[209.106898] Dynamic subtest mman: SUCCESS (4.170s)
[209.111465] Starting dynamic subtest: dmabuf
[209.705467] Dynamic subtest dmabuf: SUCCESS (0.598s)
[209.711671] Starting dynamic subtest: vma
[210.293666] Dynamic subtest vma: SUCCESS (0.587s)
[210.298603] Starting dynamic subtest: coherency
[211.584761] Dynamic subtest coherency: SUCCESS (1.290s)
[211.589431] Starting dynamic subtest: gtt
[219.102461] Dynamic subtest gtt: SUCCESS (7.516s)
[219.107012] Starting dynamic subtest: gem
[219.856615] Dynamic subtest gem: SUCCESS (0.753s)
[219.861622] Starting dynamic subtest: evict
[221.429562] Dynamic subtest evict: SUCCESS (1.572s)
[221.434122] Starting dynamic subtest: hugepages
[228.506470] Dynamic subtest hugepages: SUCCESS (7.076s)
[228.511513] Starting dynamic subtest: gem_contexts
[241.600407] Dynamic subtest gem_contexts: SUCCESS (13.090s)
[241.605284] Starting dynamic subtest: client
[242.182223] Dynamic subtest client: SUCCESS (0.584s)
[242.186892] Starting dynamic subtest: gem_migrate
[242.739779] Dynamic subtest gem_migrate: SUCCESS (0.557s)
[242.744560] Starting dynamic subtest: reset
[243.905560] Dynamic subtest reset: SUCCESS (1.165s)
[243.911706] Starting dynamic subtest: memory_region
[244.476502] Dynamic subtest memory_region: SUCCESS (0.568s)
[244.483103] Starting dynamic subtest: hangcheck
[268.058493] Dynamic subtest hangcheck: SUCCESS (23.582s)
[268.063097] Starting dynamic subtest: execlists
[276.641553] Dynamic subtest execlists: SUCCESS (8.582s)
[276.646264] Starting dynamic subtest: ring_submission
[277.196394] Dynamic subtest ring_submission: SUCCESS (0.555s)
[277.200996] Starting dynamic subtest: perf
[277.828298] Dynamic subtest perf: SUCCESS (0.630s)
[277.835324] Starting dynamic subtest: slpc
[278.401776] Dynamic subtest slpc: SUCCESS (0.573s)
[278.406780] Starting dynamic subtest: guc
[278.974928] Dynamic subtest guc: SUCCESS (0.572s)
[278.980062] Starting dynamic subtest: guc_multi_lrc
[279.540018] Dynamic subtest guc_multi_lrc: SUCCESS (0.564s)
[279.545156] Starting dynamic subtest: guc_hang
[280.104556] Dynamic subtest guc_hang: SUCCESS (0.564s)
[280.109594] Starting dynamic subtest: late_gt_pm
[280.685694] Dynamic subtest late_gt_pm: SUCCESS (0.580s)
[280.686238] Subtest live: SUCCESS (107.199s)
[280.867521] [165/171] (720s left) dmabuf (all-tests)
[280.946129] Starting subtest: all-tests
[280.946715] Starting dynamic subtest: sanitycheck
[281.010602] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[281.021042] Starting dynamic subtest: dma_fence
[281.180944] Dynamic subtest dma_fence: SUCCESS (0.169s)
[281.187844] Starting dynamic subtest: dma_fence_chain
[294.339859] Dynamic subtest dma_fence_chain: SUCCESS (13.156s)
[294.348156] Starting dynamic subtest: dma_fence_unwrap
[294.414101] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s)
[294.445374] Starting dynamic subtest: dma_resv
[294.495111] Dynamic subtest dma_resv: SUCCESS (0.078s)
[294.496066] Subtest all-tests: SUCCESS (13.550s)
[294.515521] [166/171] (706s left) i915_suspend (basic-s2idle-without-i915)
[294.603434] Starting subtest: basic-s2idle-without-i915
[311.928461] Subtest basic-s2idle-without-i915: SUCCESS (2.052s)
[319.967131] [167/171] (704s left) i915_suspend (basic-s3-without-i915)
[320.036402] Starting subtest: basic-s3-without-i915
[338.217650] Subtest basic-s3-without-i915: SUCCESS (2.319s)
[343.270878] [168/171] (702s left) gem_exec_suspend (basic-s0)
[343.357752] Starting subtest: basic-S0
[343.359336] Starting dynamic subtest: smem
[361.078462] Dynamic subtest smem: SUCCESS (1.832s)
[361.079099] Subtest basic-S0: SUCCESS (1.833s)
[368.254877] [169/171] (700s left) gem_exec_suspend (basic-s3)
[368.361302] Starting subtest: basic-S3
[368.363298] Starting dynamic subtest: smem
[386.346022] Dynamic subtest smem: SUCCESS (2.348s)
[386.348000] Subtest basic-S3: SUCCESS (2.351s)
[390.487440] [170/171] (697s left) kms_chamelium_hpd (common-hpd-after-suspend)
[390.643894] Subtest common-hpd-after-suspend: SKIP (0.000s)
[390.658726] [171/171] (697s left) kms_pipe_crc_basic (suspend-read-crc)
[390.803116] Subtest suspend-read-crc: SKIP (0.000s)
[390.815224] Closing watchdogs
Done.