[38.079302] Initializing watchdogs
[38.079359]   /dev/watchdog0
[38.086039] [001/165] (960s left) i915_module_load (load)
[38.133845] Starting subtest: load
[39.614552] Subtest load: SUCCESS (1.482s)
[39.641434] [002/165] (958s left) core_auth (basic-auth)
[39.720215] Starting subtest: basic-auth
[39.724401] Subtest basic-auth: SUCCESS (0.001s)
[39.761027] [003/165] (958s left) debugfs_test (read_all_entries)
[39.815362] Starting subtest: read_all_entries
[39.934735] Subtest read_all_entries: SUCCESS (0.118s)
[40.031689] [004/165] (958s left) debugfs_test (basic-hwmon)
[40.080800] Starting subtest: basic-hwmon
[40.087039] Subtest basic-hwmon: SKIP (0.000s)
[40.180695] [005/165] (958s left) fbdev (eof)
[40.265421] Starting subtest: eof
[40.268871] Subtest eof: SUCCESS (0.000s)
[40.317687] [006/165] (958s left) fbdev (info)
[40.367972] Starting subtest: info
[40.371503] Subtest info: SUCCESS (0.000s)
[40.438711] [007/165] (958s left) fbdev (nullptr)
[40.515359] Starting subtest: nullptr
[40.518693] Subtest nullptr: SUCCESS (0.000s)
[40.562751] [008/165] (958s left) fbdev (read)
[40.631914] Starting subtest: read
[40.850164] Subtest read: SUCCESS (0.218s)
[40.895164] [009/165] (957s left) fbdev (write)
[40.948471] Starting subtest: write
[41.058825] Subtest write: SUCCESS (0.110s)
[41.095425] [010/165] (957s left) gem_basic (bad-close)
[41.141355] Starting subtest: bad-close
[41.147865] Subtest bad-close: SUCCESS (0.000s)
[41.202524] [011/165] (957s left) gem_basic (create-close)
[41.255324] Starting subtest: create-close
[41.261871] Subtest create-close: SUCCESS (0.000s)
[41.353323] [012/165] (957s left) gem_basic (create-fd-close)
[41.440978] Starting subtest: create-fd-close
[41.447415] Subtest create-fd-close: SUCCESS (0.000s)
[41.497771] [013/165] (957s left) gem_busy (busy@all-engines)
[41.571912] Starting subtest: busy
[41.575219] Starting dynamic subtest: all-engines
[41.592747] Dynamic subtest all-engines: SUCCESS (0.022s)
[41.596024] Subtest busy: SUCCESS (0.022s)
[41.969445] [014/165] (956s left) gem_close_race (basic-process)
[42.035518] Starting subtest: basic-process
[42.083375] Subtest basic-process: SUCCESS (0.048s)
[42.248083] [015/165] (956s left) gem_close_race (basic-threads)
[42.297682] Starting subtest: basic-threads
[43.510657] Subtest basic-threads: SUCCESS (1.214s)
[43.731049] [016/165] (955s left) gem_ctx_create (basic)
[43.794160] Starting subtest: basic
[43.797204] Subtest basic: SUCCESS (0.000s)
[44.006227] [017/165] (954s left) gem_ctx_create (basic-files)
[44.054548] Starting subtest: basic-files
[46.064446] Subtest basic-files: SUCCESS (2.012s)
[46.289459] [018/165] (952s left) gem_ctx_exec (basic)
[46.340629] Starting subtest: basic
[46.344214] Subtest basic: SUCCESS (0.002s)
[46.470079] [019/165] (952s left) gem_exec_basic (basic)
[46.536226] Starting subtest: basic
[46.539562] Starting dynamic subtest: rcs0-smem
[46.542969] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[46.549696] Starting dynamic subtest: bcs0-smem
[46.552978] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[46.560052] Starting dynamic subtest: vcs0-smem
[46.563220] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[46.570770] Starting dynamic subtest: vecs0-smem
[46.573748] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[46.576750] Subtest basic: SUCCESS (0.002s)
[46.755768] [020/165] (952s left) gem_exec_create (basic)
[46.805649] Starting subtest: basic
[46.809178] Starting dynamic subtest: smem
[48.844266] Dynamic subtest smem: SUCCESS (2.041s)
[48.847692] Subtest basic: SUCCESS (2.041s)
[49.031845] [021/165] (950s left) gem_exec_fence (basic-busy)
[49.206905] Starting subtest: basic-busy
[49.210536] Starting dynamic subtest: rcs0
[49.231176] Dynamic subtest rcs0: SUCCESS (0.024s)
[49.240456] Starting dynamic subtest: bcs0
[49.255229] Dynamic subtest bcs0: SUCCESS (0.022s)
[49.263471] Starting dynamic subtest: vcs0
[49.283691] Dynamic subtest vcs0: SUCCESS (0.030s)
[49.294130] Starting dynamic subtest: vecs0
[49.309308] Dynamic subtest vecs0: SUCCESS (0.026s)
[49.312808] Subtest basic-busy: SUCCESS (0.102s)
[49.953775] [022/165] (949s left) gem_exec_fence (basic-wait)
[50.129798] Starting subtest: basic-wait
[50.133276] Starting dynamic subtest: rcs0
[50.153461] Dynamic subtest rcs0: SUCCESS (0.023s)
[50.163166] Starting dynamic subtest: bcs0
[50.187272] Dynamic subtest bcs0: SUCCESS (0.033s)
[50.213195] Starting dynamic subtest: vcs0
[50.228552] Dynamic subtest vcs0: SUCCESS (0.041s)
[50.252953] Starting dynamic subtest: vecs0
[50.268998] Dynamic subtest vecs0: SUCCESS (0.040s)
[50.272959] Subtest basic-wait: SUCCESS (0.139s)
[50.771947] [023/165] (948s left) gem_exec_fence (basic-await)
[51.005135] Starting subtest: basic-await
[51.009435] Starting dynamic subtest: rcs0
[51.090354] Dynamic subtest rcs0: SUCCESS (0.086s)
[51.103320] Starting dynamic subtest: bcs0
[51.164111] Dynamic subtest bcs0: SUCCESS (0.073s)
[51.178324] Starting dynamic subtest: vcs0
[51.242400] Dynamic subtest vcs0: SUCCESS (0.078s)
[51.253387] Starting dynamic subtest: vecs0
[51.325296] Dynamic subtest vecs0: SUCCESS (0.082s)
[51.329830] Subtest basic-await: SUCCESS (0.321s)
[51.890286] [024/165] (947s left) gem_exec_fence (nb-await)
[52.051018] Starting subtest: nb-await
[52.054566] Starting dynamic subtest: rcs0
[52.108095] Dynamic subtest rcs0: SUCCESS (0.056s)
[52.131893] Starting dynamic subtest: bcs0
[52.180539] Dynamic subtest bcs0: SUCCESS (0.072s)
[52.204241] Starting dynamic subtest: vcs0
[52.254622] Dynamic subtest vcs0: SUCCESS (0.070s)
[52.278241] Starting dynamic subtest: vecs0
[52.321196] Dynamic subtest vecs0: SUCCESS (0.069s)
[52.325397] Subtest nb-await: SUCCESS (0.269s)
[52.874301] [025/165] (946s left) gem_exec_gttfill (basic)
[52.920684] Starting subtest: basic
[57.617854] Subtest basic: SUCCESS (4.698s)
[57.780318] [026/165] (941s left) gem_exec_parallel (engines)
[57.893491] Starting subtest: engines
[57.896371] Starting dynamic subtest: basic
[59.266879] Dynamic subtest basic: SUCCESS (1.373s)
[59.276575] Starting dynamic subtest: contexts
[61.607105] Dynamic subtest contexts: SUCCESS (2.340s)
[61.614666] Starting dynamic subtest: fds
[63.963482] Dynamic subtest fds: SUCCESS (2.285s)
[64.029551] Starting dynamic subtest: userptr
[65.848549] Dynamic subtest userptr: SUCCESS (1.863s)
[65.853143] Subtest engines: SUCCESS (7.861s)
[66.110594] [027/165] (933s left) gem_exec_store (basic)
[66.726675] Starting subtest: basic
[66.795104] Subtest basic: SUCCESS (0.055s)
[67.034367] [028/165] (932s left) gem_flink_basic (bad-flink)
[67.466133] Starting subtest: bad-flink
[67.470516] Subtest bad-flink: SUCCESS (0.000s)
[67.494838] [029/165] (932s left) gem_flink_basic (bad-open)
[67.874678] Starting subtest: bad-open
[67.941758] Subtest bad-open: SUCCESS (0.000s)
[68.176231] [030/165] (931s left) gem_flink_basic (basic)
[68.515070] Starting subtest: basic
[68.583434] Subtest basic: SUCCESS (0.000s)
[68.821533] [031/165] (931s left) gem_flink_basic (double-flink)
[69.057968] Starting subtest: double-flink
[69.061246] Subtest double-flink: SUCCESS (0.000s)
[69.288164] [032/165] (931s left) gem_flink_basic (flink-lifetime)
[69.626233] Starting subtest: flink-lifetime
[69.694229] Subtest flink-lifetime: SUCCESS (0.003s)
[69.931727] [033/165] (930s left) gem_huc_copy (huc-copy)
[70.271962] Starting subtest: huc-copy
[70.340067] Subtest huc-copy: SUCCESS (0.001s)
[70.630965] [034/165] (930s left) gem_linear_blits (basic)
[71.169849] Starting subtest: basic
[71.336738] Subtest basic: SUCCESS (0.004s)
[72.228599] [035/165] (928s left) gem_mmap (basic)
[72.365447] Starting subtest: basic
[72.382048] Subtest basic: SUCCESS (0.000s)
[72.602073] [036/165] (928s left) gem_mmap_gtt (basic)
[73.165276] Starting subtest: basic
[73.233577] Subtest basic: SUCCESS (0.001s)
[73.472207] [037/165] (928s left) gem_render_linear_blits (basic)
[73.936944] Starting subtest: basic
[73.957585] Subtest basic: SUCCESS (0.017s)
[74.075141] [038/165] (927s left) gem_render_tiled_blits (basic)
[74.575511] Starting subtest: basic
[74.979534] Subtest basic: SUCCESS (0.021s)
[75.284647] [039/165] (927s left) gem_ringfill (basic-all)
[75.859405] Starting subtest: basic-all
[76.879549] Subtest basic-all: SUCCESS (1.126s)
[77.248535] [040/165] (925s left) gem_softpin (allocator-basic)
[77.718184] Starting subtest: allocator-basic
[77.786143] Subtest allocator-basic: SUCCESS (0.058s)
[78.023069] [041/165] (925s left) gem_softpin (allocator-basic-reserve)
[78.362523] Starting subtest: allocator-basic-reserve
[78.430071] Subtest allocator-basic-reserve: SUCCESS (0.059s)
[78.701546] [042/165] (924s left) gem_softpin (safe-alignment)
[79.086781] Starting subtest: safe-alignment
[79.154284] Subtest safe-alignment: SUCCESS (0.007s)
[79.390982] [043/165] (924s left) gem_sync (basic-all)
[80.272321] Starting subtest: basic-all
[81.782408] Subtest basic-all: SUCCESS (2.131s)
[81.970716] [044/165] (921s left) gem_sync (basic-each)
[82.046933] Starting subtest: basic-each
[84.105357] Subtest basic-each: SUCCESS (2.079s)
[84.325603] [045/165] (919s left) gem_tiled_blits (basic)
[84.456316] Starting subtest: basic
[84.469380] Subtest basic: SUCCESS (0.013s)
[84.637290] [046/165] (919s left) gem_tiled_fence_blits (basic)
[84.854843] Starting subtest: basic
[84.862903] Subtest basic: SUCCESS (0.006s)
[85.018861] [047/165] (918s left) gem_tiled_pread_basic
[85.284824] [048/165] (918s left) gem_wait (busy@all-engines)
[85.338701] Starting subtest: busy
[85.341867] Starting dynamic subtest: all-engines
[85.852216] Dynamic subtest all-engines: SUCCESS (0.513s)
[85.855771] Subtest busy: SUCCESS (0.513s)
[86.054578] [049/165] (917s left) gem_wait (wait@all-engines)
[86.103880] Starting subtest: wait
[86.107163] Starting dynamic subtest: all-engines
[87.129470] Dynamic subtest all-engines: SUCCESS (1.025s)
[87.133703] Subtest wait: SUCCESS (1.025s)
[87.327585] [050/165] (916s left) i915_getparams_basic (basic-eu-total)
[87.374680] Starting subtest: basic-eu-total
[87.380944] Subtest basic-eu-total: SUCCESS (0.000s)
[87.442454] [051/165] (916s left) i915_getparams_basic (basic-subslice-total)
[87.499650] Starting subtest: basic-subslice-total
[87.506708] Subtest basic-subslice-total: SUCCESS (0.000s)
[87.549272] [052/165] (916s left) i915_hangman (error-state-basic)
[87.600007] Starting subtest: error-state-basic
[87.648088] Subtest error-state-basic: SUCCESS (0.048s)
[87.700184] [053/165] (916s left) i915_pciid
[87.818521] [054/165] (916s left) kms_addfb_basic (addfb25-4-tiled)
[87.936675] Starting subtest: addfb25-4-tiled
[87.939445] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[88.007504] [055/165] (916s left) kms_addfb_basic (addfb25-bad-modifier)
[88.091706] Starting subtest: addfb25-bad-modifier
[88.095107] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[88.230062] [056/165] (915s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[88.322450] Starting subtest: addfb25-framebuffer-vs-set-tiling
[88.325709] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[88.433758] [057/165] (915s left) kms_addfb_basic (addfb25-modifier-no-flag)
[88.488532] Starting subtest: addfb25-modifier-no-flag
[88.491661] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[88.631246] [058/165] (915s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[88.691392] Starting subtest: addfb25-x-tiled-legacy
[88.694408] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[88.827337] [059/165] (915s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[88.915200] Starting subtest: addfb25-x-tiled-mismatch-legacy
[88.918412] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[89.069871] [060/165] (915s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[89.174536] Starting subtest: addfb25-yf-tiled-legacy
[89.177881] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[89.252869] [061/165] (915s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[89.349601] Starting subtest: addfb25-y-tiled-legacy
[89.352886] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[89.419799] [062/165] (914s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[89.545853] Starting subtest: addfb25-y-tiled-small-legacy
[89.548989] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[89.620924] [063/165] (914s left) kms_addfb_basic (bad-pitch-0)
[89.701403] Starting subtest: bad-pitch-0
[89.704578] Subtest bad-pitch-0: SUCCESS (0.000s)
[89.820040] [064/165] (914s left) kms_addfb_basic (bad-pitch-1024)
[89.876152] Starting subtest: bad-pitch-1024
[89.879043] Subtest bad-pitch-1024: SUCCESS (0.000s)
[89.985359] [065/165] (914s left) kms_addfb_basic (bad-pitch-128)
[90.064366] Starting subtest: bad-pitch-128
[90.067684] Subtest bad-pitch-128: SUCCESS (0.000s)
[90.200845] [066/165] (914s left) kms_addfb_basic (bad-pitch-256)
[90.252492] Starting subtest: bad-pitch-256
[90.255386] Subtest bad-pitch-256: SUCCESS (0.000s)
[90.407043] [067/165] (914s left) kms_addfb_basic (bad-pitch-32)
[90.490986] Starting subtest: bad-pitch-32
[90.494114] Subtest bad-pitch-32: SUCCESS (0.000s)
[90.624593] [068/165] (913s left) kms_addfb_basic (bad-pitch-63)
[90.702144] Starting subtest: bad-pitch-63
[90.705221] Subtest bad-pitch-63: SUCCESS (0.000s)
[90.818955] [069/165] (913s left) kms_addfb_basic (bad-pitch-65536)
[90.884130] Starting subtest: bad-pitch-65536
[90.887378] Subtest bad-pitch-65536: SUCCESS (0.000s)
[91.000044] [070/165] (913s left) kms_addfb_basic (bad-pitch-999)
[91.046043] Starting subtest: bad-pitch-999
[91.049135] Subtest bad-pitch-999: SUCCESS (0.000s)
[91.206297] [071/165] (913s left) kms_addfb_basic (basic)
[91.251482] Starting subtest: basic
[91.254526] Subtest basic: SUCCESS (0.000s)
[91.370142] [072/165] (913s left) kms_addfb_basic (basic-x-tiled-legacy)
[91.447265] Starting subtest: basic-x-tiled-legacy
[91.450480] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[91.572918] [073/165] (913s left) kms_addfb_basic (basic-y-tiled-legacy)
[91.652278] Starting subtest: basic-y-tiled-legacy
[91.655441] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[91.768630] [074/165] (912s left) kms_addfb_basic (bo-too-small)
[91.891154] Starting subtest: bo-too-small
[91.894253] Subtest bo-too-small: SUCCESS (0.000s)
[91.971685] [075/165] (912s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[92.072204] Starting subtest: bo-too-small-due-to-tiling
[92.076344] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[92.157294] [076/165] (912s left) kms_addfb_basic (clobberred-modifier)
[92.245259] Starting subtest: clobberred-modifier
[92.248668] Subtest clobberred-modifier: SUCCESS (0.000s)
[92.375511] [077/165] (912s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[92.460887] Starting subtest: framebuffer-vs-set-tiling
[92.463795] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[92.593277] [078/165] (912s left) kms_addfb_basic (invalid-get-prop)
[92.649113] Starting subtest: invalid-get-prop
[92.652195] Subtest invalid-get-prop: SUCCESS (0.000s)
[92.763263] [079/165] (912s left) kms_addfb_basic (invalid-get-prop-any)
[92.824175] Starting subtest: invalid-get-prop-any
[92.827268] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[92.959380] [080/165] (911s left) kms_addfb_basic (invalid-set-prop)
[93.015865] Starting subtest: invalid-set-prop
[93.019108] Subtest invalid-set-prop: SUCCESS (0.000s)
[93.129328] [081/165] (911s left) kms_addfb_basic (invalid-set-prop-any)
[93.183300] Starting subtest: invalid-set-prop-any
[93.186441] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[93.301832] [082/165] (911s left) kms_addfb_basic (no-handle)
[93.355596] Starting subtest: no-handle
[93.358733] Subtest no-handle: SUCCESS (0.000s)
[93.495696] [083/165] (911s left) kms_addfb_basic (size-max)
[93.599877] Starting subtest: size-max
[93.602979] Subtest size-max: SUCCESS (0.000s)
[93.667729] [084/165] (911s left) kms_addfb_basic (small-bo)
[93.786165] Starting subtest: small-bo
[93.789282] Subtest small-bo: SUCCESS (0.000s)
[93.850321] [085/165] (911s left) kms_addfb_basic (tile-pitch-mismatch)
[93.915146] Starting subtest: tile-pitch-mismatch
[93.918443] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[94.036340] [086/165] (910s left) kms_addfb_basic (too-high)
[94.154787] Starting subtest: too-high
[94.158007] Subtest too-high: SUCCESS (0.000s)
[94.241813] [087/165] (910s left) kms_addfb_basic (too-wide)
[94.342170] Starting subtest: too-wide
[94.345244] Subtest too-wide: SUCCESS (0.000s)
[94.423155] [088/165] (910s left) kms_addfb_basic (unused-handle)
[94.504607] Starting subtest: unused-handle
[94.507719] Subtest unused-handle: SUCCESS (0.000s)
[94.617513] [089/165] (910s left) kms_addfb_basic (unused-modifier)
[94.668230] Starting subtest: unused-modifier
[94.671071] Subtest unused-modifier: SUCCESS (0.000s)
[94.787155] [090/165] (910s left) kms_addfb_basic (unused-offsets)
[94.864466] Starting subtest: unused-offsets
[94.867358] Subtest unused-offsets: SUCCESS (0.000s)
[95.016775] [091/165] (910s left) kms_addfb_basic (unused-pitches)
[95.074816] Starting subtest: unused-pitches
[95.077614] Subtest unused-pitches: SUCCESS (0.000s)
[95.208070] [092/165] (909s left) kms_busy (basic)
[95.314186] Starting subtest: basic
[95.317903] Starting dynamic subtest: flip
[95.923327] Dynamic subtest flip: SUCCESS (0.607s)
[95.931472] Starting dynamic subtest: modeset
[96.476257] Dynamic subtest modeset: SUCCESS (0.556s)
[96.479222] Subtest basic: SUCCESS (1.163s)
[96.622243] [093/165] (908s left) kms_prop_blob (basic)
[96.681853] Starting subtest: basic
[96.685167] Subtest basic: SUCCESS (0.000s)
[96.740303] [094/165] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[96.865829] Starting subtest: basic-busy-flip-before-cursor-atomic
[96.871976] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[96.915317] [095/165] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[97.033321] Starting subtest: basic-busy-flip-before-cursor-legacy
[97.039193] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[97.100309] [096/165] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[97.211785] Starting subtest: basic-flip-after-cursor-atomic
[98.230999] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.943s)
[98.526102] [097/165] (906s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[98.796418] Starting subtest: basic-flip-after-cursor-legacy
[99.828957] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.962s)
[100.068280] [098/165] (905s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[100.338966] Starting subtest: basic-flip-after-cursor-varying-size
[101.305524] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.947s)
[101.608948] [099/165] (904s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[101.881088] Starting subtest: basic-flip-before-cursor-atomic
[102.786207] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.957s)
[102.907146] [100/165] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[102.999925] Starting subtest: basic-flip-before-cursor-legacy
[103.961790] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.962s)
[104.076951] [101/165] (901s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[104.175532] Starting subtest: basic-flip-before-cursor-varying-size
[105.108425] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.932s)
[105.242304] [102/165] (900s left) kms_dsc (dsc-basic)
[105.341795] Subtest dsc-basic: SKIP (0.000s)
[105.366591] [103/165] (900s left) kms_flip (basic-flip-vs-dpms)
[105.464226] Starting subtest: basic-flip-vs-dpms
[105.467058] Starting dynamic subtest: A-HDMI-A1
[106.376549] Dynamic subtest A-HDMI-A1: SUCCESS (0.911s)
[106.384179] Starting dynamic subtest: B-HDMI-A1
[107.233066] Dynamic subtest B-HDMI-A1: SUCCESS (0.856s)
[107.244186] Starting dynamic subtest: C-HDMI-A1
[108.093747] Dynamic subtest C-HDMI-A1: SUCCESS (0.859s)
[108.096999] Subtest basic-flip-vs-dpms: SUCCESS (2.633s)
[108.217613] [104/165] (897s left) kms_flip (basic-flip-vs-modeset)
[108.317013] Starting subtest: basic-flip-vs-modeset
[108.320211] Starting dynamic subtest: A-HDMI-A1
[109.224897] Dynamic subtest A-HDMI-A1: SUCCESS (0.909s)
[109.234116] Starting dynamic subtest: B-HDMI-A1
[110.059795] Dynamic subtest B-HDMI-A1: SUCCESS (0.834s)
[110.069135] Starting dynamic subtest: C-HDMI-A1
[110.892119] Dynamic subtest C-HDMI-A1: SUCCESS (0.832s)
[110.895060] Subtest basic-flip-vs-modeset: SUCCESS (2.581s)
[111.022468] [105/165] (895s left) kms_flip (basic-flip-vs-wf_vblank)
[111.122307] Starting subtest: basic-flip-vs-wf_vblank
[111.124831] Starting dynamic subtest: A-HDMI-A1
[112.381090] Dynamic subtest A-HDMI-A1: SUCCESS (1.164s)
[112.446993] Starting dynamic subtest: B-HDMI-A1
[113.504508] Dynamic subtest B-HDMI-A1: SUCCESS (1.124s)
[113.571529] Starting dynamic subtest: C-HDMI-A1
[114.651322] Dynamic subtest C-HDMI-A1: SUCCESS (1.126s)
[114.718710] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.420s)
[114.956383] [106/165] (891s left) kms_flip (basic-plain-flip)
[115.363763] Starting subtest: basic-plain-flip
[115.431712] Starting dynamic subtest: A-HDMI-A1
[116.117074] Dynamic subtest A-HDMI-A1: SUCCESS (0.856s)
[116.184032] Starting dynamic subtest: B-HDMI-A1
[116.945886] Dynamic subtest B-HDMI-A1: SUCCESS (0.841s)
[117.013933] Starting dynamic subtest: C-HDMI-A1
[117.808269] Dynamic subtest C-HDMI-A1: SUCCESS (0.840s)
[117.876379] Subtest basic-plain-flip: SUCCESS (2.542s)
[118.116600] [107/165] (888s left) kms_force_connector_basic (force-connector-state)
[118.595145] Starting subtest: force-connector-state
[118.920740] Subtest force-connector-state: SUCCESS (0.293s)
[119.413974] [108/165] (887s left) kms_force_connector_basic (force-edid)
[119.892328] Starting subtest: force-edid
[120.200229] Subtest force-edid: SUCCESS (0.329s)
[120.564877] [109/165] (886s left) kms_force_connector_basic (force-load-detect)
[121.005023] Starting subtest: force-load-detect
[121.139384] Subtest force-load-detect: SKIP (0.000s)
[121.377518] [110/165] (885s left) kms_force_connector_basic (prune-stale-modes)
[121.715684] Starting subtest: prune-stale-modes
[121.852530] Subtest prune-stale-modes: SUCCESS (0.135s)
[122.126706] [111/165] (885s left) kms_frontbuffer_tracking (basic)
[122.713557] Starting subtest: basic
[124.884747] Subtest basic: SUCCESS (2.396s)
[125.122723] [112/165] (882s left) kms_hdmi_inject (inject-audio)
[125.646373] Starting subtest: inject-audio
[125.844544] Subtest inject-audio: SUCCESS (0.107s)
[126.078911] [113/165] (881s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[126.587293] Starting subtest: compare-crc-sanitycheck-xr24
[126.655268] Starting dynamic subtest: pipe-A-HDMI-A-1
[126.876309] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.395s)
[126.884608] Starting dynamic subtest: pipe-B-HDMI-A-1
[127.311252] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.366s)
[127.378614] Starting dynamic subtest: pipe-C-HDMI-A-1
[127.714992] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.365s)
[127.782561] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.129s)
[128.023254] [114/165] (879s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[128.364832] Starting subtest: compare-crc-sanitycheck-nv12
[128.501084] Starting dynamic subtest: pipe-A-HDMI-A-1
[128.751094] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.424s)
[128.818370] Starting dynamic subtest: pipe-B-HDMI-A-1
[129.157852] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.394s)
[129.225810] Starting dynamic subtest: pipe-C-HDMI-A-1
[129.359878] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[129.427077] Subtest compare-crc-sanitycheck-nv12: SUCCESS (0.823s)
[129.664033] [115/165] (878s left) kms_pipe_crc_basic (hang-read-crc)
[130.061951] Starting subtest: hang-read-crc
[130.065513] Starting dynamic subtest: pipe-A-HDMI-A-1
[131.050272] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.983s)
[131.118211] Starting dynamic subtest: pipe-B-HDMI-A-1
[132.010725] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.969s)
[132.078348] Starting dynamic subtest: pipe-C-HDMI-A-1
[132.968081] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.955s)
[133.036075] Subtest hang-read-crc: SUCCESS (2.911s)
[133.230770] [116/165] (874s left) kms_pipe_crc_basic (nonblocking-crc)
[133.338155] Starting subtest: nonblocking-crc
[133.341311] Starting dynamic subtest: pipe-A-HDMI-A-1
[133.884715] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.544s)
[133.893173] Starting dynamic subtest: pipe-B-HDMI-A-1
[134.379771] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.495s)
[134.389727] Starting dynamic subtest: pipe-C-HDMI-A-1
[134.897462] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.516s)
[134.900380] Subtest nonblocking-crc: SUCCESS (1.559s)
[135.007378] [117/165] (873s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[135.102196] Starting subtest: nonblocking-crc-frame-sequence
[135.105264] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.626352] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.525s)
[135.635884] Starting dynamic subtest: pipe-B-HDMI-A-1
[136.122660] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.496s)
[136.132422] Starting dynamic subtest: pipe-C-HDMI-A-1
[136.625884] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.501s)
[136.628978] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.526s)
[136.727799] [118/165] (871s left) kms_pipe_crc_basic (read-crc)
[136.825053] Starting subtest: read-crc
[136.828122] Starting dynamic subtest: pipe-A-HDMI-A-1
[137.312701] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.485s)
[137.321025] Starting dynamic subtest: pipe-B-HDMI-A-1
[137.773645] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.460s)
[137.782066] Starting dynamic subtest: pipe-C-HDMI-A-1
[138.235684] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.461s)
[138.238717] Subtest read-crc: SUCCESS (1.409s)
[138.342633] [119/165] (869s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[138.444336] Starting subtest: read-crc-frame-sequence
[138.447343] Starting dynamic subtest: pipe-A-HDMI-A-1
[138.923945] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.478s)
[138.932383] Starting dynamic subtest: pipe-B-HDMI-A-1
[139.385531] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.461s)
[139.394015] Starting dynamic subtest: pipe-C-HDMI-A-1
[139.848695] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.462s)
[139.851632] Subtest read-crc-frame-sequence: SUCCESS (1.404s)
[139.956439] [120/165] (868s left) kms_pm_backlight (basic-brightness)
[140.061475] Subtest basic-brightness: SKIP (0.000s)
[140.078521] [121/165] (868s left) kms_pm_rpm (basic-pci-d3-state)
[141.591240] Starting subtest: basic-pci-d3-state
[141.925497] Subtest basic-pci-d3-state: SUCCESS (0.333s)
[142.411558] [122/165] (865s left) kms_pm_rpm (basic-rte)
[142.456704] Starting subtest: basic-rte
[144.086775] Subtest basic-rte: SUCCESS (1.633s)
[144.808694] [123/165] (863s left) kms_psr (psr_primary_page_flip)
[144.906487] Subtest psr_primary_page_flip: SKIP (0.000s)
[144.931946] [124/165] (863s left) kms_psr (psr_cursor_plane_move)
[145.030919] Subtest psr_cursor_plane_move: SKIP (0.000s)
[145.048745] [125/165] (863s left) kms_psr (psr_sprite_plane_onoff)
[145.149362] Subtest psr_sprite_plane_onoff: SKIP (0.000s)
[145.167025] [126/165] (863s left) kms_psr (psr_primary_mmap_gtt)
[145.261206] Subtest psr_primary_mmap_gtt: SKIP (0.000s)
[145.283175] [127/165] (862s left) kms_setmode (basic-clone-single-crtc)
[145.334697] Starting subtest: basic-clone-single-crtc
[145.344991] Subtest basic-clone-single-crtc: SKIP (0.000s)
[145.419128] [128/165] (862s left) i915_pm_rps (basic-api)
[145.478622] Starting subtest: basic-api
[145.481994] Subtest basic-api: SUCCESS (0.002s)
[145.556707] [129/165] (862s left) prime_self_import (basic-llseek-bad)
[145.643765] Starting subtest: basic-llseek-bad
[145.650512] Subtest basic-llseek-bad: SUCCESS (0.001s)
[145.739558] [130/165] (862s left) prime_self_import (basic-llseek-size)
[145.794572] Starting subtest: basic-llseek-size
[145.801480] Subtest basic-llseek-size: SUCCESS (0.001s)
[145.862027] [131/165] (862s left) prime_self_import (basic-with_fd_dup)
[145.935594] Starting subtest: basic-with_fd_dup
[145.942453] Subtest basic-with_fd_dup: SUCCESS (0.001s)
[146.055368] [132/165] (862s left) prime_self_import (basic-with_one_bo)
[146.135114] Starting subtest: basic-with_one_bo
[146.141917] Subtest basic-with_one_bo: SUCCESS (0.002s)
[146.211984] [133/165] (862s left) prime_self_import (basic-with_one_bo_two_files)
[146.296659] Starting subtest: basic-with_one_bo_two_files
[146.303635] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[146.427972] [134/165] (862s left) prime_self_import (basic-with_two_bos)
[146.483656] Starting subtest: basic-with_two_bos
[146.490252] Subtest basic-with_two_bos: SUCCESS (0.002s)
[146.567237] [135/165] (862s left) prime_vgem (basic-fence-flip)
[146.644258] Starting subtest: basic-fence-flip
[147.073196] Subtest basic-fence-flip: SUCCESS (0.431s)
[147.203406] [136/165] (861s left) prime_vgem (basic-fence-mmap)
[147.264111] Starting subtest: basic-fence-mmap
[147.274406] Subtest basic-fence-mmap: SUCCESS (0.017s)
[147.380632] [137/165] (861s left) prime_vgem (basic-fence-read)
[147.445557] Starting subtest: basic-fence-read
[147.467388] Subtest basic-fence-read: SUCCESS (0.026s)
[147.606663] [138/165] (861s left) prime_vgem (basic-gtt)
[147.701346] Starting subtest: basic-gtt
[147.707894] Subtest basic-gtt: SUCCESS (0.008s)
[147.813314] [139/165] (860s left) prime_vgem (basic-read)
[147.879903] Starting subtest: basic-read
[147.886283] Subtest basic-read: SUCCESS (0.012s)
[147.965962] [140/165] (860s left) prime_vgem (basic-write)
[148.027487] Starting subtest: basic-write
[148.038819] Subtest basic-write: SUCCESS (0.013s)
[148.111082] [141/165] (860s left) vgem_basic (setversion)
[148.175154] Starting subtest: setversion
[148.181977] Subtest setversion: SUCCESS (0.000s)
[148.227526] [142/165] (860s left) vgem_basic (create)
[148.317843] Starting subtest: create
[148.321302] Subtest create: SUCCESS (0.000s)
[148.340849] [143/165] (860s left) vgem_basic (debugfs)
[148.408677] Starting subtest: debugfs
[148.412438] Subtest debugfs: SUCCESS (0.000s)
[148.470236] [144/165] (860s left) vgem_basic (dmabuf-export)
[148.562175] Starting subtest: dmabuf-export
[148.569490] Subtest dmabuf-export: SUCCESS (0.001s)
[148.652521] [145/165] (860s left) vgem_basic (dmabuf-fence)
[148.707860] Starting subtest: dmabuf-fence
[148.711203] Subtest dmabuf-fence: SUCCESS (0.000s)
[148.763707] [146/165] (860s left) vgem_basic (dmabuf-fence-before)
[148.824341] Starting subtest: dmabuf-fence-before
[148.827603] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[148.876340] [147/165] (860s left) vgem_basic (dmabuf-mmap)
[148.924712] Starting subtest: dmabuf-mmap
[148.931394] Subtest dmabuf-mmap: SUCCESS (0.009s)
[148.969562] [148/165] (860s left) vgem_basic (mmap)
[149.024170] Starting subtest: mmap
[149.030544] Subtest mmap: SUCCESS (0.007s)
[149.071111] [149/165] (859s left) vgem_basic (second-client)
[149.141149] Starting subtest: second-client
[149.177068] Subtest second-client: SUCCESS (0.034s)
[149.251208] [150/165] (859s left) vgem_basic (sysfs)
[149.340877] Starting subtest: sysfs
[149.343943] Subtest sysfs: SUCCESS (0.000s)
[149.389712] [151/165] (859s left) core_hotunplug (unbind-rebind)
[149.488268] Starting subtest: unbind-rebind
[152.883325] Subtest unbind-rebind: SUCCESS (3.394s)
[152.901059] [152/165] (856s left) vgem_basic (unload)
[152.949201] Starting subtest: unload
[181.857506] Subtest unload: SUCCESS (28.910s)
[181.955673] [153/165] (827s left) i915_module_load (reload)
[182.013352] Starting subtest: reload
[184.458650] Subtest reload: SUCCESS (2.448s)
[184.483369] [154/165] (824s left) gem_lmem_swapping (basic)
[184.547064] Subtest basic: SKIP (0.000s)
[184.568999] [155/165] (824s left) gem_lmem_swapping (parallel-random-engines)
[184.631560] Subtest parallel-random-engines: SKIP (0.000s)
[184.647908] [156/165] (824s left) gem_lmem_swapping (random-engines)
[184.707114] Subtest random-engines: SKIP (0.000s)
[184.727279] [157/165] (824s left) gem_lmem_swapping (verify-random)
[184.805328] Subtest verify-random: SKIP (0.000s)
[184.841201] [158/165] (824s left) i915_pm_rpm (module-reload)
[186.757574] Starting subtest: module-reload
[193.740905] Subtest module-reload: SUCCESS (6.987s)
[193.758092] [159/165] (815s left) i915_selftest (live)
[193.811595] Starting subtest: live
[193.814735] Starting dynamic subtest: sanitycheck
[194.914312] Dynamic subtest sanitycheck: SUCCESS (1.101s)
[194.922131] Starting dynamic subtest: uncore
[196.022560] Dynamic subtest uncore: SUCCESS (1.109s)
[196.030057] Starting dynamic subtest: workarounds
[197.294501] Dynamic subtest workarounds: SUCCESS (1.271s)
[197.301640] Starting dynamic subtest: gt_engines
[198.831484] Dynamic subtest gt_engines: SUCCESS (1.536s)
[198.838971] Starting dynamic subtest: gt_timelines
[205.755443] Dynamic subtest gt_timelines: SUCCESS (6.923s)
[205.763055] Starting dynamic subtest: gt_contexts
[206.975528] Dynamic subtest gt_contexts: SUCCESS (1.219s)
[206.982611] Starting dynamic subtest: gt_lrc
[210.386077] Dynamic subtest gt_lrc: SUCCESS (3.349s)
[210.454553] Starting dynamic subtest: gt_mocs
[211.538568] Dynamic subtest gt_mocs: SUCCESS (1.212s)
[211.546276] Starting dynamic subtest: gt_pm
[214.550605] Dynamic subtest gt_pm: SUCCESS (3.011s)
[214.558195] Starting dynamic subtest: gt_heartbeat
[215.722686] Dynamic subtest gt_heartbeat: SUCCESS (1.171s)
[215.731130] Starting dynamic subtest: gt_tlb
[217.634516] Dynamic subtest gt_tlb: SUCCESS (1.911s)
[217.641675] Starting dynamic subtest: requests
[224.933561] Dynamic subtest requests: SUCCESS (7.298s)
[224.940761] Starting dynamic subtest: migrate
[229.231333] Dynamic subtest migrate: SUCCESS (4.297s)
[229.238702] Starting dynamic subtest: active
[230.386259] Dynamic subtest active: SUCCESS (1.152s)
[230.393489] Starting dynamic subtest: objects
[232.046577] Dynamic subtest objects: SUCCESS (1.661s)
[232.054385] Starting dynamic subtest: mman
[236.424482] Dynamic subtest mman: SUCCESS (4.377s)
[236.432030] Starting dynamic subtest: dmabuf
[237.609451] Dynamic subtest dmabuf: SUCCESS (1.184s)
[237.617222] Starting dynamic subtest: vma
[238.696529] Dynamic subtest vma: SUCCESS (1.086s)
[238.703720] Starting dynamic subtest: coherency
[241.014613] Dynamic subtest coherency: SUCCESS (2.317s)
[241.022838] Starting dynamic subtest: gtt
[249.100612] Dynamic subtest gtt: SUCCESS (8.085s)
[249.107811] Starting dynamic subtest: gem
[250.311826] Dynamic subtest gem: SUCCESS (1.210s)
[250.319719] Starting dynamic subtest: evict
[252.206431] Dynamic subtest evict: SUCCESS (1.894s)
[252.213973] Starting dynamic subtest: hugepages
[259.259658] Dynamic subtest hugepages: SUCCESS (7.052s)
[259.267184] Starting dynamic subtest: gem_contexts
[271.936635] Dynamic subtest gem_contexts: SUCCESS (12.676s)
[271.944561] Starting dynamic subtest: client
[273.090651] Dynamic subtest client: SUCCESS (1.153s)
[273.098858] Starting dynamic subtest: gem_migrate
[274.217659] Dynamic subtest gem_migrate: SUCCESS (1.126s)
[274.225197] Starting dynamic subtest: reset
[275.666860] Dynamic subtest reset: SUCCESS (1.448s)
[275.678201] Starting dynamic subtest: memory_region
[276.778567] Dynamic subtest memory_region: SUCCESS (1.111s)
[276.786512] Starting dynamic subtest: hangcheck
[300.920204] Dynamic subtest hangcheck: SUCCESS (24.139s)
[300.927905] Starting dynamic subtest: execlists
[309.836645] Dynamic subtest execlists: SUCCESS (8.917s)
[309.845141] Starting dynamic subtest: ring_submission
[310.969555] Dynamic subtest ring_submission: SUCCESS (1.132s)
[310.977294] Starting dynamic subtest: perf
[312.190733] Dynamic subtest perf: SUCCESS (1.220s)
[312.198861] Starting dynamic subtest: slpc
[313.320487] Dynamic subtest slpc: SUCCESS (1.129s)
[313.328020] Starting dynamic subtest: guc
[314.435437] Dynamic subtest guc: SUCCESS (1.114s)
[314.443013] Starting dynamic subtest: guc_multi_lrc
[315.521397] Dynamic subtest guc_multi_lrc: SUCCESS (1.085s)
[315.528444] Starting dynamic subtest: guc_hang
[316.639557] Dynamic subtest guc_hang: SUCCESS (1.117s)
[316.647137] Starting dynamic subtest: late_gt_pm
[317.801606] Dynamic subtest late_gt_pm: SUCCESS (1.161s)
[317.804903] Subtest live: SUCCESS (123.990s)
[317.822724] [160/165] (691s left) dmabuf (all-tests)
[317.931886] Starting subtest: all-tests
[317.935599] Starting dynamic subtest: sanitycheck
[318.005198] Dynamic subtest sanitycheck: SUCCESS (0.076s)
[318.032139] Starting dynamic subtest: dma_fence
[318.195493] Dynamic subtest dma_fence: SUCCESS (0.188s)
[318.220914] Starting dynamic subtest: dma_fence_chain
[328.346389] Dynamic subtest dma_fence_chain: SUCCESS (10.149s)
[328.357305] Starting dynamic subtest: dma_fence_unwrap
[328.427505] Dynamic subtest dma_fence_unwrap: SUCCESS (0.079s)
[328.435997] Starting dynamic subtest: dma_resv
[328.499252] Dynamic subtest dma_resv: SUCCESS (0.068s)
[328.503686] Subtest all-tests: SUCCESS (10.572s)
[328.555155] [161/165] (680s left) i915_suspend (basic-s2idle-without-i915)
[328.637653] Starting subtest: basic-s2idle-without-i915
[347.168566] Subtest basic-s2idle-without-i915: SUCCESS (3.293s)
[351.309423] [162/165] (677s left) i915_suspend (basic-s3-without-i915)
[351.358289] Starting subtest: basic-s3-without-i915
[370.638233] Subtest basic-s3-without-i915: SUCCESS (2.802s)
[375.729731] [163/165] (674s left) gem_exec_suspend (basic-s0)
[375.786837] Starting subtest: basic-S0
[375.790116] Starting dynamic subtest: smem
[392.638932] Dynamic subtest smem: SUCCESS (1.716s)
[392.642181] Subtest basic-S0: SUCCESS (1.717s)
[401.808711] [164/165] (672s left) gem_exec_suspend (basic-s3)
[401.860567] Starting subtest: basic-S3
[401.864088] Starting dynamic subtest: smem
[419.857018] Dynamic subtest smem: SUCCESS (1.952s)
[419.860282] Subtest basic-S3: SUCCESS (1.953s)
[429.075657] [165/165] (670s left) kms_pipe_crc_basic (suspend-read-crc)
[429.180570] Starting subtest: suspend-read-crc
[429.183385] Starting dynamic subtest: pipe-A-HDMI-A-1
[447.966504] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.893s)
[447.979883] Starting dynamic subtest: pipe-B-HDMI-A-1
[466.006003] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.378s)
[466.015576] Starting dynamic subtest: pipe-C-HDMI-A-1
[484.002475] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.927s)
[484.005474] Subtest suspend-read-crc: SUCCESS (6.201s)
[489.074441] Closing watchdogs
Done.