[47.652833] Initializing watchdogs
[47.652899]   /dev/watchdog0
[47.669746] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[47.675214] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[47.678357] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[47.680236] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[47.774184] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[47.775596] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[47.863172] [002/134] (960s left) gem_exec_params (secure-non-master)
[47.900411] Starting subtest: secure-non-master
[47.901732] Subtest secure-non-master: SKIP (0.000s)
[48.005732] [003/134] (960s left) tools_test (tools_test)
[48.039121] Starting subtest: tools_test
[48.112125] Subtest tools_test: SUCCESS (0.078s)
[48.200411] [004/134] (960s left) kms_selftest (drm_cmdline_parser)
[48.232369] Starting subtest: drm_cmdline_parser
[48.240276] Starting dynamic subtest: drm_test_cmdline_force_d_only
[48.332678] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.094s)
[48.343598] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[48.438246] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.105s)
[48.449094] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[48.536556] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.099s)
[48.547151] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[48.616407] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.079s)
[48.627316] Starting dynamic subtest: drm_test_cmdline_force_e_only
[48.710409] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.094s)
[48.721445] Starting dynamic subtest: drm_test_cmdline_res
[48.786313] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.076s)
[48.797059] Starting dynamic subtest: drm_test_cmdline_res_vesa
[48.877461] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.091s)
[48.885494] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[48.960923] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.082s)
[48.972233] Starting dynamic subtest: drm_test_cmdline_res_rblank
[49.034778] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.075s)
[49.045777] Starting dynamic subtest: drm_test_cmdline_res_bpp
[49.110726] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.075s)
[49.122056] Starting dynamic subtest: drm_test_cmdline_res_refresh
[49.200662] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.091s)
[49.211495] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[49.279748] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.080s)
[49.287582] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[49.366746] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.088s)
[49.377962] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[49.448181] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.080s)
[49.458852] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[49.532042] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.084s)
[49.542324] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[49.613238] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.081s)
[49.623658] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[49.693325] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.080s)
[49.704032] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[49.770212] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.077s)
[49.780534] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[49.853300] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.083s)
[49.864173] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[49.933141] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.080s)
[49.943779] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[50.014955] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.082s)
[50.023070] Starting dynamic subtest: drm_test_cmdline_name
[50.094020] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.079s)
[50.105860] Starting dynamic subtest: drm_test_cmdline_name_bpp
[50.189068] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.096s)
[50.200976] Starting dynamic subtest: drm_test_cmdline_name_option
[50.273942] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.084s)
[50.285759] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[50.370493] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.097s)
[50.382248] Starting dynamic subtest: drm_test_cmdline_rotate_0
[50.468740] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.098s)
[50.480561] Starting dynamic subtest: drm_test_cmdline_rotate_90
[50.560992] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.092s)
[50.572076] Starting dynamic subtest: drm_test_cmdline_rotate_180
[50.664501] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.104s)
[50.675846] Starting dynamic subtest: drm_test_cmdline_rotate_270
[50.765606] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.101s)
[50.776735] Starting dynamic subtest: drm_test_cmdline_hmirror
[50.844561] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.079s)
[50.855649] Starting dynamic subtest: drm_test_cmdline_vmirror
[50.928037] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.083s)
[50.939183] Starting dynamic subtest: drm_test_cmdline_margin_options
[51.011399] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.084s)
[51.022712] Starting dynamic subtest: drm_test_cmdline_multiple_options
[51.088591] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.077s)
[51.100321] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[51.172077] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.083s)
[51.178691] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[51.243945] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.072s)
[51.254362] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[51.329235] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.085s)
[51.340078] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[51.412066] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.082s)
[51.422592] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[51.493047] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.081s)
[51.504208] Starting dynamic subtest: drm_test_cmdline_invalid
[51.603035] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.110s)
[51.611194] Starting dynamic subtest: drm_test_cmdline_tv_options
[51.698150] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.094s)
[51.698989] Subtest drm_cmdline_parser: SUCCESS (3.494s)
[51.850729] [005/134] (956s left) gem_exec_suspend (basic-s0)
[51.891316] Starting subtest: basic-S0
[51.892008] Starting dynamic subtest: smem
[69.773985] Dynamic subtest smem: SUCCESS (2.846s)
[69.774702] Subtest basic-S0: SUCCESS (2.846s)
[78.987953] [006/134] (938s left) kms_content_protection (uevent)
[79.089252] Starting subtest: uevent
[79.102936] Subtest uevent: SKIP (0.012s)
[79.220259] [007/134] (938s left) gem_eio (in-flight-suspend)
[79.262438] Starting subtest: in-flight-suspend
[116.277483] Subtest in-flight-suspend: SUCCESS (7.607s)
[124.417035] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[124.428979] [008/134] (901s left) gem_spin_batch (resubmit-all)
[124.470290] Starting subtest: resubmit-all
[124.470984] Starting dynamic subtest: rcs0
[124.473862] Dynamic subtest rcs0: SUCCESS (0.004s)
[124.480955] Starting dynamic subtest: bcs0
[124.481664] Dynamic subtest bcs0: SUCCESS (0.002s)
[124.487681] Starting dynamic subtest: vcs0
[124.488363] Dynamic subtest vcs0: SUCCESS (0.002s)
[124.494040] Starting dynamic subtest: vcs1
[124.494707] Dynamic subtest vcs1: SUCCESS (0.002s)
[124.500182] Starting dynamic subtest: vecs0
[124.500838] Dynamic subtest vecs0: SUCCESS (0.002s)
[124.501497] Subtest resubmit-all: SUCCESS (0.013s)
[124.676813] [009/134] (900s left) kms_psr (psr-cursor-plane-onoff)
[124.761622] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[124.803001] [010/134] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[124.890336] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[124.891685] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[125.018314] [011/134] (900s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[125.106079] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[125.107378] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[125.224303] [012/134] (900s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[125.311014] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[125.347527] [013/134] (900s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[125.435531] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[125.472031] [014/134] (900s left) kms_pm_rpm (basic-pci-d3-state)
[126.883571] Starting subtest: basic-pci-d3-state
[128.177412] Subtest basic-pci-d3-state: SUCCESS (1.304s)
[128.295283] [015/134] (897s left) gem_ctx_exec (basic-norecovery)
[128.330730] Starting subtest: basic-norecovery
[128.346935] Subtest basic-norecovery: SUCCESS (0.016s)
[128.470719] [016/134] (897s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[128.568097] Starting subtest: protected-encrypted-src-copy-not-readible
[128.652207] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.086s)
[128.766057] [017/134] (897s left) kms_flip (absolute-wf_vblank)
[128.848893] Starting subtest: absolute-wf_vblank
[128.850455] Starting dynamic subtest: A-HDMI-A1
[136.602482] Dynamic subtest A-HDMI-A1: SUCCESS (7.762s)
[136.608826] Starting dynamic subtest: B-HDMI-A1
[144.356249] Dynamic subtest B-HDMI-A1: SUCCESS (7.759s)
[144.362663] Starting dynamic subtest: C-HDMI-A1
[152.081936] Dynamic subtest C-HDMI-A1: SUCCESS (7.733s)
[152.088966] Starting dynamic subtest: D-HDMI-A1
[159.716778] Dynamic subtest D-HDMI-A1: SUCCESS (7.658s)
[159.717693] Subtest absolute-wf_vblank: SUCCESS (30.918s)
[159.878444] [018/134] (866s left) prime_mmap (test_refcounting)
[159.911937] Starting subtest: test_refcounting
[159.912627] Starting dynamic subtest: test_refcounting-smem
[159.914200] Dynamic subtest test_refcounting-smem: SUCCESS (0.002s)
[159.914919] Subtest test_refcounting: SUCCESS (0.002s)
[160.029911] [019/134] (865s left) gem_exec_schedule (pi-common)
[160.194407] Starting subtest: pi-common
[160.195316] Starting dynamic subtest: rcs0
[160.230393] Dynamic subtest rcs0: SUCCESS (0.036s)
[160.237255] Starting dynamic subtest: bcs0
[160.256300] Dynamic subtest bcs0: SUCCESS (0.025s)
[160.262999] Starting dynamic subtest: vcs0
[160.279803] Dynamic subtest vcs0: SUCCESS (0.024s)
[160.286656] Starting dynamic subtest: vcs1
[160.303402] Dynamic subtest vcs1: SUCCESS (0.023s)
[160.310304] Starting dynamic subtest: vecs0
[160.327228] Dynamic subtest vecs0: SUCCESS (0.023s)
[160.327943] Subtest pi-common: SUCCESS (0.133s)
[160.504158] [020/134] (865s left) perf (unprivileged-single-ctx-counters)
[160.599620] Starting subtest: unprivileged-single-ctx-counters
[160.601043] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[160.639585] [021/134] (865s left) api_intel_allocator (fork-simple-stress-signal)
[160.672173] Starting subtest: fork-simple-stress-signal
[166.128793] Subtest fork-simple-stress-signal: SUCCESS (5.420s)
[166.190484] [022/134] (859s left) kms_flip (flip-vs-panning-vs-hang)
[166.278525] Starting subtest: flip-vs-panning-vs-hang
[166.279203] Starting dynamic subtest: A-HDMI-A1
[194.128464] Dynamic subtest A-HDMI-A1: SUCCESS (27.839s)
[194.134894] Starting dynamic subtest: D-HDMI-A1
[233.041962] Dynamic subtest D-HDMI-A1: SUCCESS (38.903s)
[233.042822] Subtest flip-vs-panning-vs-hang: SUCCESS (66.747s)
[233.254344] [023/134] (792s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[233.345168] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[233.387309] [024/134] (792s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[233.420190] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[233.420877] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[233.502422] [025/134] (792s left) gem_exec_create (basic)
[233.542338] Starting subtest: basic
[233.543060] Starting dynamic subtest: smem
[235.598946] Dynamic subtest smem: SUCCESS (2.056s)
[235.599657] Subtest basic: SUCCESS (2.057s)
[235.789384] [026/134] (790s left) gem_ctx_persistence (smoketest)
[235.826088] Starting subtest: smoketest
[274.146760] Subtest smoketest: SUCCESS (38.321s)
[274.221455] [027/134] (752s left) gem_ctx_bad_destroy (invalid-pad)
[274.252625] Starting subtest: invalid-pad
[274.253311] Subtest invalid-pad: SUCCESS (0.000s)
[274.328729] [028/134] (751s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[274.416770] Starting subtest: cursorA-vs-flipB-legacy
[274.418823] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[274.482819] [029/134] (751s left) kms_atomic_interruptible (legacy-setmode)
[274.567396] Starting subtest: legacy-setmode
[274.568834] Starting dynamic subtest: pipe-A-HDMI-A-1
[280.747131] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.179s)
[280.747880] Subtest legacy-setmode: SUCCESS (6.181s)
[280.921276] [030/134] (745s left) kms_cdclk (mode-transition)
[280.954207] Subtest mode-transition: SKIP (0.000s)
[280.998376] [031/134] (745s left) kms_big_fb (linear-8bpp-rotate-270)
[281.094567] Starting subtest: linear-8bpp-rotate-270
[281.173063] Subtest linear-8bpp-rotate-270: SKIP (0.078s)
[281.298139] [032/134] (745s left) perf_pmu (faulting-read)
[281.333369] Starting subtest: faulting-read
[281.334054] Starting dynamic subtest: gtt
[281.334786] Dynamic subtest gtt: SUCCESS (0.001s)
[281.343143] Starting dynamic subtest: wb
[281.343829] Dynamic subtest wb: SUCCESS (0.001s)
[281.350960] Starting dynamic subtest: wc
[281.351634] Dynamic subtest wc: SUCCESS (0.000s)
[281.357977] Starting dynamic subtest: uc
[281.358667] Dynamic subtest uc: SUCCESS (0.000s)
[281.359344] Subtest faulting-read: SUCCESS (0.004s)
[281.438317] [033/134] (745s left) kms_psr (fbc-psr2-primary-render)
[281.523252] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[281.570462] [034/134] (744s left) gem_exec_schedule (deep)
[281.734398] Starting subtest: deep
[281.735363] Starting dynamic subtest: rcs0
[289.669603] Dynamic subtest rcs0: SUCCESS (7.929s)
[289.678804] Starting dynamic subtest: bcs0
[297.869658] Dynamic subtest bcs0: SUCCESS (8.201s)
[297.879325] Starting dynamic subtest: vcs0
[306.104597] Dynamic subtest vcs0: SUCCESS (8.236s)
[306.111681] Starting dynamic subtest: vcs1
[314.329076] Dynamic subtest vcs1: SUCCESS (8.226s)
[314.339057] Starting dynamic subtest: vecs0
[322.554664] Dynamic subtest vecs0: SUCCESS (8.226s)
[322.555496] Subtest deep: SUCCESS (40.821s)
[323.131495] [035/134] (703s left) kms_selftest (drm_plane_helper)
[323.163167] Starting subtest: drm_plane_helper
[323.173345] Starting dynamic subtest: drm_test_check_plane_state
[323.266838] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.093s)
[323.281800] Starting dynamic subtest: drm_test_check_invalid_plane_state
[323.362898] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.096s)
[323.364014] Subtest drm_plane_helper: SUCCESS (0.200s)
[323.520423] [036/134] (703s left) syncobj_basic (bad-pad-fd-to-handle)
[323.552007] Starting subtest: bad-pad-fd-to-handle
[323.552686] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[323.627899] [037/134] (703s left) gem_lmem_swapping (parallel-random-engines)
[323.663132] Subtest parallel-random-engines: SKIP (0.000s)
[323.702752] [038/134] (703s left) kms_mmap_write_crc (main)
[323.792022] Starting subtest: main
[323.793494] Starting dynamic subtest: pipe-A-HDMI-A-1
[325.255921] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.463s)
[325.256690] Subtest main: SUCCESS (1.464s)
[325.395689] [039/134] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[325.491088] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[325.492398] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[325.605933] [040/134] (701s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[325.690285] Starting subtest: addfb25-yf-tiled-legacy
[325.690980] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[325.797050] [041/134] (701s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[325.885479] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[325.886891] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[326.005430] [042/134] (700s left) gem_ctx_exec (basic)
[326.039135] Starting subtest: basic
[326.041081] Subtest basic: SUCCESS (0.002s)
[326.180188] [043/134] (700s left) kms_atomic (test-only)
[326.265697] Starting subtest: test-only
[326.326614] Starting dynamic subtest: pipe-A-HDMI-A-1
[326.730311] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.405s)
[326.731026] Subtest test-only: SUCCESS (0.465s)
[326.874708] [044/134] (700s left) gem_set_tiling_vs_gtt
[327.356157] [045/134] (699s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[327.450826] Starting subtest: yf-tiled-16bpp-rotate-0
[327.452132] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[327.565152] [046/134] (699s left) kms_getfb (getfb2-handle-zero)
[327.650300] Starting subtest: getfb2-handle-zero
[327.650993] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[327.759989] [047/134] (699s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[327.793588] Starting subtest: single-wait-all-for-submit-available-submitted
[327.794374] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[327.858209] [048/134] (699s left) gem_exec_reloc (basic-wc-cpu)
[327.895896] Starting subtest: basic-wc-cpu
[327.901177] Subtest basic-wc-cpu: SUCCESS (0.005s)
[328.026459] [049/134] (699s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[328.116220] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[328.117557] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[328.236409] [050/134] (698s left) gem_basic (multigpu-create-close)
[328.268075] Starting subtest: multigpu-create-close
[328.269401] Subtest multigpu-create-close: SKIP (0.000s)
[328.350400] [051/134] (698s left) kms_frontbuffer_tracking (fbc-suspend)
[328.438182] Starting subtest: fbc-suspend
[364.445591] Subtest fbc-suspend: SUCCESS (5.105s)
[372.633586] [052/134] (662s left) gem_wait (wait)
[372.679085] Starting subtest: wait
[372.679779] Starting dynamic subtest: all-engines
[373.709214] Dynamic subtest all-engines: SUCCESS (1.042s)
[373.719061] Starting dynamic subtest: rcs0
[374.734162] Dynamic subtest rcs0: SUCCESS (1.034s)
[374.744465] Starting dynamic subtest: bcs0
[375.765326] Dynamic subtest bcs0: SUCCESS (1.039s)
[375.775037] Starting dynamic subtest: vcs0
[376.790262] Dynamic subtest vcs0: SUCCESS (1.032s)
[376.805087] Starting dynamic subtest: vcs1
[377.814332] Dynamic subtest vcs1: SUCCESS (1.030s)
[377.824985] Starting dynamic subtest: vecs0
[378.847047] Dynamic subtest vecs0: SUCCESS (1.038s)
[378.848026] Subtest wait: SUCCESS (6.222s)
[379.045193] [053/134] (656s left) gem_exec_reloc (basic-wc-active)
[379.080361] Starting subtest: basic-wc-active
[379.208834] Subtest basic-wc-active: SUCCESS (0.120s)
[379.337266] [054/134] (656s left) kms_pm_rpm (pc8-residency)
[380.725553] Starting subtest: pc8-residency
[380.727562] Subtest pc8-residency: SKIP (0.000s)
[380.940394] [055/134] (654s left) kms_dsc (dsc-with-bpc-formats)
[381.027496] Starting subtest: dsc-with-bpc-formats
[381.060614] Subtest dsc-with-bpc-formats: SKIP (0.006s)
[381.118785] [056/134] (654s left) kms_psr (pr-cursor-plane-move)
[381.202201] Subtest pr-cursor-plane-move: SKIP (0.000s)
[381.266090] [057/134] (654s left) kms_vblank (ts-continuation-dpms-suspend)
[381.348949] Starting subtest: ts-continuation-dpms-suspend
[381.350729] Starting dynamic subtest: pipe-A-HDMI-A-1
[398.329660] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.415s)
[398.344424] Starting dynamic subtest: pipe-D-HDMI-A-1
[415.288517] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.391s)
[415.289194] Subtest ts-continuation-dpms-suspend: SUCCESS (2.814s)
[423.502171] [058/134] (620s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[423.535479] Starting subtest: multi-wait-available-unsubmitted-signaled
[423.536149] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[423.616563] [059/134] (620s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[423.701756] Starting subtest: basic-flip-before-cursor-legacy
[424.226685] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.525s)
[424.381007] [060/134] (619s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[424.518391] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[424.611043] [061/134] (619s left) gem_exec_params (invalid-flag)
[424.649394] Starting subtest: invalid-flag
[424.650106] Subtest invalid-flag: SUCCESS (0.000s)
[424.756517] [062/134] (618s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[424.843730] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[424.845093] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[424.954102] [063/134] (618s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[424.988002] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[424.988715] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[425.076645] [064/134] (618s left) prime_vgem (wait)
[425.150371] Starting subtest: wait
[425.151327] Starting dynamic subtest: rcs0
[425.193950] Dynamic subtest rcs0: SUCCESS (0.046s)
[425.204544] Starting dynamic subtest: bcs0
[425.211486] Dynamic subtest bcs0: SUCCESS (0.017s)
[425.225308] Starting dynamic subtest: vcs0
[425.236185] Dynamic subtest vcs0: SUCCESS (0.024s)
[425.248378] Starting dynamic subtest: vcs1
[425.272557] Dynamic subtest vcs1: SUCCESS (0.035s)
[425.289512] Starting dynamic subtest: vecs0
[425.302973] Dynamic subtest vecs0: SUCCESS (0.029s)
[425.303899] Subtest wait: SUCCESS (0.157s)
[425.449284] [065/134] (618s left) gem_exec_capture (capture)
[425.484398] Starting subtest: capture
[425.485095] Starting dynamic subtest: rcs0-smem
[426.760949] Dynamic subtest rcs0-smem: SUCCESS (1.279s)
[426.768048] Starting dynamic subtest: bcs0-smem
[428.032653] Dynamic subtest bcs0-smem: SUCCESS (1.279s)
[428.039790] Starting dynamic subtest: vcs0-smem
[429.304553] Dynamic subtest vcs0-smem: SUCCESS (1.278s)
[429.311699] Starting dynamic subtest: vcs1-smem
[430.577203] Dynamic subtest vcs1-smem: SUCCESS (1.278s)
[430.584232] Starting dynamic subtest: vecs0-smem
[431.848835] Dynamic subtest vecs0-smem: SUCCESS (1.277s)
[431.849503] Subtest capture: SUCCESS (6.394s)
[431.982909] [066/134] (611s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[432.075597] Starting subtest: cursor-rapid-movement-512x512
[432.077339] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[432.201892] [067/134] (611s left) kms_flip (2x-flip-vs-wf_vblank)
[432.285771] Starting subtest: 2x-flip-vs-wf_vblank
[432.294975] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s)
[432.367172] [068/134] (611s left) i915_pm_freq_api (freq-suspend)
[432.402347] Subtest freq-suspend: SKIP (0.000s)
[432.442540] [069/134] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[432.529559] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[432.530909] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[432.654282] [070/134] (611s left) kms_chamelium_frames (hdmi-aspect-ratio)
[432.787053] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[432.874578] [071/134] (611s left) kms_cursor_crc (cursor-sliding-max-size)
[432.969982] Starting subtest: cursor-sliding-max-size
[432.972014] Subtest cursor-sliding-max-size: SKIP (0.000s)
[433.086701] [072/134] (611s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[433.174041] Starting subtest: plane-ctm3x4-lut1d
[433.189598] Starting dynamic subtest: pipe-A-HDMI-A-1
[433.355837] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.167s)
[433.514790] Starting dynamic subtest: pipe-B-HDMI-A-1
[433.661831] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.156s)
[433.792348] Starting dynamic subtest: pipe-C-HDMI-A-1
[433.947010] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.164s)
[434.102062] Starting dynamic subtest: pipe-D-HDMI-A-1
[434.242133] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.148s)
[434.308658] Subtest plane-ctm3x4-lut1d: SUCCESS (1.138s)
[434.432309] [073/134] (609s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[434.536515] Starting subtest: psr-1p-pri-indfb-multidraw
[434.537866] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[434.647389] [074/134] (609s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[434.734758] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[434.736077] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[434.863931] [075/134] (609s left) syncobj_timeline (invalid-query-illegal-handle)
[434.896557] Starting subtest: invalid-query-illegal-handle
[434.897263] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[434.964761] [076/134] (609s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[435.048888] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[435.049558] Starting dynamic subtest: pipe-A-HDMI-A-1
[435.056072] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[435.063291] Starting dynamic subtest: pipe-B-HDMI-A-1
[435.069895] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[435.076946] Starting dynamic subtest: pipe-C-HDMI-A-1
[435.083557] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[435.090748] Starting dynamic subtest: pipe-D-HDMI-A-1
[435.097381] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[435.098732] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.009s)
[435.285306] [077/134] (609s left) kms_addfb_basic (too-high)
[435.369792] Starting subtest: too-high
[435.370467] Subtest too-high: SUCCESS (0.001s)
[435.469276] [078/134] (608s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[435.556749] Starting subtest: psr-rgb565-draw-mmap-gtt
[435.558079] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[435.669038] [079/134] (608s left) gem_mmap_offset (mmap-unmap)
[435.701913] Starting subtest: mmap-unmap
[435.702608] Starting dynamic subtest: smem0
[467.602873] Dynamic subtest smem0: SUCCESS (31.912s)
[467.603675] Subtest mmap-unmap: SUCCESS (31.913s)
[467.720318] [080/134] (576s left) gem_pread (exhaustion)
[467.753979] Starting subtest: exhaustion
[471.661279] Subtest exhaustion: SUCCESS (3.900s)
[472.004697] [081/134] (572s left) kms_joiner (invalid-modeset-ultra-joiner)
[472.091839] Starting subtest: invalid-modeset-ultra-joiner
[472.093165] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[472.172801] [082/134] (572s left) i915_drm_fdinfo (basics)
[472.207520] Starting subtest: basics
[472.208246] Subtest basics: SUCCESS (0.000s)
[472.284437] [083/134] (572s left) gem_ccs (ctrl-surf-copy-new-ctx)
[472.321485] Starting subtest: ctrl-surf-copy-new-ctx
[472.322894] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[472.403279] [084/134] (572s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[472.488035] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[472.507229] Starting dynamic subtest: pipe-A-plane-0
[472.940504] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[472.956591] Starting dynamic subtest: pipe-A-plane-3
[473.315436] Dynamic subtest pipe-A-plane-3: SUCCESS (0.373s)
[473.330856] Starting dynamic subtest: pipe-A-plane-5
[473.598737] Dynamic subtest pipe-A-plane-5: SUCCESS (0.282s)
[473.615153] Starting dynamic subtest: pipe-A-plane-7
[473.616716] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[473.760936] Starting dynamic subtest: pipe-B-plane-0
[474.145920] Dynamic subtest pipe-B-plane-0: SUCCESS (0.392s)
[474.161058] Starting dynamic subtest: pipe-B-plane-3
[474.546001] Dynamic subtest pipe-B-plane-3: SUCCESS (0.398s)
[474.561786] Starting dynamic subtest: pipe-B-plane-5
[474.821321] Dynamic subtest pipe-B-plane-5: SUCCESS (0.273s)
[474.836585] Starting dynamic subtest: pipe-B-plane-7
[474.838122] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[474.894216] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.407s)
[475.040735] [085/134] (569s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[475.131808] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[475.133167] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[475.249273] [086/134] (569s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[475.334161] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[475.334885] Starting dynamic subtest: pipe-A-valid-mode
[476.528851] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.193s)
[476.529550] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.195s)
[476.672436] [087/134] (568s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[476.766811] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[476.768154] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[476.883990] [088/134] (567s left) kms_draw_crc (fill-fb)
[476.969178] Starting subtest: fill-fb
[477.169574] Subtest fill-fb: SUCCESS (0.200s)
[477.284040] [089/134] (567s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[477.377078] Starting subtest: y-tiled-8bpp-rotate-0
[478.336521] Subtest y-tiled-8bpp-rotate-0: SUCCESS (0.959s)
[478.465634] [090/134] (566s left) gem_render_copy (yf-tiled-to-vebox-linear)
[478.504112] Starting subtest: yf-tiled-to-vebox-linear
[478.504804] Starting dynamic subtest: smem
[478.567428] Dynamic subtest smem: SUCCESS (0.063s)
[478.568211] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.064s)
[478.750031] [091/134] (566s left) syncobj_wait (invalid-reset-illegal-handle)
[478.784227] Starting subtest: invalid-reset-illegal-handle
[478.784955] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[478.864463] [092/134] (566s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[478.954796] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[478.956152] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[479.056932] [093/134] (565s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[479.151154] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[479.152497] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[479.267182] [094/134] (565s left) api_intel_bb (full-batch)
[479.300490] Starting subtest: full-batch
[479.302929] Subtest full-batch: SUCCESS (0.003s)
[479.442361] [095/134] (565s left) kms_psr (fbc-psr-basic)
[479.527597] Subtest fbc-psr-basic: SKIP (0.000s)
[479.567557] [096/134] (565s left) gem_exercise_blt (fast-copy-emit)
[479.602312] Starting subtest: fast-copy-emit
[479.603094] Starting dynamic subtest: linear-smem-smem-emit
[479.621904] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.019s)
[479.630584] Starting dynamic subtest: ymajor-smem-smem-emit
[479.639214] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.016s)
[479.648026] Starting dynamic subtest: tile4-smem-smem-emit
[479.656058] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[479.664889] Starting dynamic subtest: tile64-smem-smem-emit
[479.672780] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[479.673479] Subtest fast-copy-emit: SUCCESS (0.071s)
[479.809235] [097/134] (565s left) sysfs_heartbeat_interval (mixed)
[479.845495] Starting subtest: mixed
[479.847694] Starting dynamic subtest: vecs0
[485.076296] Dynamic subtest vecs0: SUCCESS (5.231s)
[485.089162] Starting dynamic subtest: vcs0
[490.310247] Dynamic subtest vcs0: SUCCESS (5.232s)
[490.322609] Starting dynamic subtest: bcs0
[495.515167] Dynamic subtest bcs0: SUCCESS (5.203s)
[495.526018] Starting dynamic subtest: rcs0
[500.686247] Dynamic subtest rcs0: SUCCESS (5.169s)
[500.698312] Starting dynamic subtest: vcs1
[505.905258] Dynamic subtest vcs1: SUCCESS (5.218s)
[505.906602] Subtest mixed: SUCCESS (26.069s)
[506.031752] [098/134] (539s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[506.119017] Starting subtest: cursor-vs-flip-legacy
[535.730564] Subtest cursor-vs-flip-legacy: SUCCESS (29.608s)
[535.878424] [099/134] (509s left) gem_exec_schedule (semaphore-resolve)
[535.925868] Starting subtest: semaphore-resolve
[535.943879] Subtest semaphore-resolve: SUCCESS (0.019s)
[536.247177] [100/134] (509s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[536.336457] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[536.337890] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[536.456018] [101/134] (508s left) kms_cursor_legacy (torture-bo)
[536.540124] Starting subtest: torture-bo
[536.540812] Starting dynamic subtest: pipe-A
[542.062289] Dynamic subtest pipe-A: SUCCESS (5.487s)
[542.070998] Starting dynamic subtest: pipe-B
[547.573992] Dynamic subtest pipe-B: SUCCESS (5.501s)
[547.589566] Starting dynamic subtest: pipe-C
[553.151023] Dynamic subtest pipe-C: SUCCESS (5.576s)
[553.163878] Starting dynamic subtest: pipe-D
[558.832616] Dynamic subtest pipe-D: SUCCESS (5.682s)
[558.842377] Starting dynamic subtest: all-pipes
[564.966764] Dynamic subtest all-pipes: SUCCESS (6.158s)
[564.967427] Subtest torture-bo: SUCCESS (28.418s)
[565.071554] [102/134] (480s left) gem_ctx_shared (q-independent)
[565.113515] Starting subtest: Q-independent
[565.114224] Starting dynamic subtest: rcs0
[565.133257] Dynamic subtest rcs0: SUCCESS (0.021s)
[565.142394] Starting dynamic subtest: bcs0
[565.154035] Dynamic subtest bcs0: SUCCESS (0.020s)
[565.163022] Starting dynamic subtest: vcs0
[565.174321] Dynamic subtest vcs0: SUCCESS (0.019s)
[565.183261] Starting dynamic subtest: vcs1
[565.195408] Dynamic subtest vcs1: SUCCESS (0.020s)
[565.204313] Starting dynamic subtest: vecs0
[565.216404] Dynamic subtest vecs0: SUCCESS (0.020s)
[565.217128] Subtest Q-independent: SUCCESS (0.105s)
[565.419583] [103/134] (480s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[565.870308] Starting subtest: syncobj-timeline-invalid-wait
[565.871247] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[566.060942] [104/134] (479s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[566.098480] Starting subtest: y-tiled-ccs-to-x-tiled
[566.099192] Starting dynamic subtest: smem
[566.201751] Dynamic subtest smem: SUCCESS (0.103s)
[566.202468] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.104s)
[566.393810] [105/134] (479s left) drm_read (short-buffer-wakeup)
[566.503754] Starting subtest: short-buffer-wakeup
[598.720109] Subtest short-buffer-wakeup: SUCCESS (32.214s)
[598.831708] [106/134] (446s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[598.923163] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[598.923906] Starting dynamic subtest: pipe-A-HDMI-A-1
[598.984921] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.061s)
[599.053740] Starting dynamic subtest: pipe-B-HDMI-A-1
[599.209542] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.165s)
[599.259531] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.336s)
[599.412543] [107/134] (446s left) syncobj_timeline (device-submit-unordered)
[599.448565] Starting subtest: device-submit-unordered
[599.449256] Subtest device-submit-unordered: SUCCESS (0.000s)
[599.535387] [108/134] (446s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[599.620120] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[599.620800] Starting dynamic subtest: pipe-A-HDMI-A-1
[599.637267] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[599.644538] Starting dynamic subtest: pipe-B-HDMI-A-1
[599.668701] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[599.676002] Starting dynamic subtest: pipe-C-HDMI-A-1
[599.693425] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[599.703006] Starting dynamic subtest: pipe-D-HDMI-A-1
[599.720604] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[599.721955] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.014s)
[599.883998] [109/134] (445s left) kms_pipe_crc_basic (nonblocking-crc)
[599.970097] Starting subtest: nonblocking-crc
[599.970781] Starting dynamic subtest: pipe-A-HDMI-A-1
[600.328521] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.357s)
[600.337165] Starting dynamic subtest: pipe-B-HDMI-A-1
[600.641555] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.311s)
[600.651295] Starting dynamic subtest: pipe-C-HDMI-A-1
[600.976804] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.332s)
[600.988230] Starting dynamic subtest: pipe-D-HDMI-A-1
[601.308701] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.330s)
[601.309678] Subtest nonblocking-crc: SUCCESS (1.340s)
[601.436591] [110/134] (444s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[601.531932] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[602.606517] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (1.075s)
[602.743972] [111/134] (443s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[602.837804] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[604.045816] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.209s)
[604.184803] [112/134] (441s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[604.273001] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[604.287145] Starting dynamic subtest: pipe-A-plane-0
[604.288492] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[604.295891] Starting dynamic subtest: pipe-A-plane-3
[604.297259] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[604.304550] Starting dynamic subtest: pipe-A-plane-5
[604.305928] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[604.313039] Starting dynamic subtest: pipe-A-plane-7
[604.314385] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[604.413165] Starting dynamic subtest: pipe-B-plane-0
[604.414498] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[604.421898] Starting dynamic subtest: pipe-B-plane-3
[604.423229] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[604.430485] Starting dynamic subtest: pipe-B-plane-5
[604.431825] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[604.439288] Starting dynamic subtest: pipe-B-plane-7
[604.440652] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[604.480150] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.207s)
[604.633736] [113/134] (441s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[604.721010] Starting subtest: plane-downscale-factor-0-5-with-rotation
[604.721675] Starting dynamic subtest: pipe-A
[605.871281] Dynamic subtest pipe-A: SKIP (1.148s)
[605.886308] Starting dynamic subtest: pipe-B
[606.991191] Dynamic subtest pipe-B: SKIP (1.120s)
[606.998529] Starting dynamic subtest: pipe-C
[608.125843] Dynamic subtest pipe-C: SKIP (1.134s)
[608.133309] Starting dynamic subtest: pipe-D
[609.242351] Dynamic subtest pipe-D: SKIP (1.116s)
[609.243774] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (4.522s)
[609.441300] [114/134] (436s left) perf_pmu (busy-hang)
[609.484827] Starting subtest: busy-hang
[609.485540] Starting dynamic subtest: rcs0
[610.549353] Dynamic subtest rcs0: SUCCESS (1.064s)
[610.557760] Starting dynamic subtest: bcs0
[611.582215] Dynamic subtest bcs0: SUCCESS (1.031s)
[611.593016] Starting dynamic subtest: vcs0
[612.629668] Dynamic subtest vcs0: SUCCESS (1.042s)
[612.638318] Starting dynamic subtest: vcs1
[613.686469] Dynamic subtest vcs1: SUCCESS (1.057s)
[613.695527] Starting dynamic subtest: vecs0
[614.746221] Dynamic subtest vecs0: SUCCESS (1.058s)
[614.747148] Subtest busy-hang: SUCCESS (5.262s)
[614.829938] [115/134] (431s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[614.922916] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[614.923605] Starting dynamic subtest: pipe-A-HDMI-A-1
[614.930061] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[614.937403] Starting dynamic subtest: pipe-B-HDMI-A-1
[614.943844] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[614.951101] Starting dynamic subtest: pipe-C-HDMI-A-1
[614.957536] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[614.964813] Starting dynamic subtest: pipe-D-HDMI-A-1
[614.971394] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[614.972688] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[615.167454] [116/134] (430s left) kms_cursor_crc (cursor-offscreen-128x42)
[615.259315] Starting subtest: cursor-offscreen-128x42
[615.264957] Starting dynamic subtest: pipe-A-HDMI-A-1
[616.520551] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.256s)
[616.554680] Starting dynamic subtest: pipe-D-HDMI-A-1
[617.762485] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.216s)
[617.763187] Subtest cursor-offscreen-128x42: SUCCESS (2.505s)
[617.910653] [117/134] (428s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[618.003148] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[618.003874] Starting dynamic subtest: pipe-A
[618.135583] Dynamic subtest pipe-A: SUCCESS (0.133s)
[618.144105] Starting dynamic subtest: pipe-B
[618.277764] Dynamic subtest pipe-B: SUCCESS (0.141s)
[618.290910] Starting dynamic subtest: pipe-C
[618.412995] Dynamic subtest pipe-C: SUCCESS (0.134s)
[618.421507] Starting dynamic subtest: pipe-D
[618.555776] Dynamic subtest pipe-D: SUCCESS (0.142s)
[618.556524] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.554s)
[618.758738] [118/134] (427s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[618.855037] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[619.456258] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.602s)
[619.603681] [119/134] (426s left) syncobj_basic (bad-pad-handle-to-fd)
[619.636560] Starting subtest: bad-pad-handle-to-fd
[619.637242] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[619.716972] [120/134] (426s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[619.802997] Starting subtest: cursorA-vs-flipB-atomic-transitions
[619.804352] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[619.893348] [121/134] (426s left) kms_frontbuffer_tracking (psr-2p-rte)
[619.982960] Starting subtest: psr-2p-rte
[619.984375] Subtest psr-2p-rte: SKIP (0.000s)
[620.083858] [122/134] (426s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[620.174590] Starting subtest: psr-shrfb-scaledprimary
[620.175934] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[620.294737] [123/134] (425s left) gen7_exec_parse (cmd-crossing-page)
[620.330940] Subtest cmd-crossing-page: SKIP (0.000s)
[620.368916] [124/134] (425s left) kms_frontbuffer_tracking (fbc-1p-rte)
[620.461364] Starting subtest: fbc-1p-rte
[623.216970] Subtest fbc-1p-rte: SUCCESS (2.758s)
[623.372514] [125/134] (422s left) gem_mmap_wc (write)
[623.406264] Starting subtest: write
[623.440017] Subtest write: SUCCESS (0.034s)
[623.521827] [126/134] (422s left) kms_busy (extended-modeset-hang-newfb)
[623.613432] Starting subtest: extended-modeset-hang-newfb
[623.615653] Starting dynamic subtest: pipe-A
[647.405489] Dynamic subtest pipe-A: SUCCESS (23.795s)
[647.417176] Starting dynamic subtest: pipe-D
[671.461826] Dynamic subtest pipe-D: SUCCESS (24.045s)
[671.462549] Subtest extended-modeset-hang-newfb: SUCCESS (47.847s)
[671.598149] [127/134] (374s left) i915_pm_rpm (gem-evict-pwrite)
[672.996200] Starting subtest: gem-evict-pwrite
[674.261062] Subtest gem-evict-pwrite: SUCCESS (1.258s)
[674.444385] [128/134] (372s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[674.531533] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[674.532255] Starting dynamic subtest: pipe-A-HDMI-A-1
[674.538461] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[674.546043] Starting dynamic subtest: pipe-B-HDMI-A-1
[674.552102] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[674.559461] Starting dynamic subtest: pipe-C-HDMI-A-1
[674.565439] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[674.572600] Starting dynamic subtest: pipe-D-HDMI-A-1
[674.578504] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[674.579185] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.009s)
[674.781705] [129/134] (371s left) i915_suspend (basic-s2idle-without-i915)
[674.812741] Starting subtest: basic-s2idle-without-i915
[693.272231] Subtest basic-s2idle-without-i915: SUCCESS (3.184s)
[700.347875] [130/134] (353s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[700.437673] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[700.438403] Starting dynamic subtest: pipe-A-valid-mode
[701.429612] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.003s)
[701.431419] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.005s)
[701.572505] [131/134] (352s left) kms_big_fb (4-tiled-addfb)
[701.672033] Starting subtest: 4-tiled-addfb
[701.673466] Subtest 4-tiled-addfb: SKIP (0.000s)
[701.771949] [132/134] (351s left) kms_setmode (basic-clone-single-crtc)
[701.804702] Starting subtest: basic-clone-single-crtc
[701.806800] Subtest basic-clone-single-crtc: SKIP (0.000s)
[701.876883] [133/134] (351s left) gem_exec_balancer (full-late-pulse)
[701.919206] Starting subtest: full-late-pulse
[703.528046] Subtest full-late-pulse: SUCCESS (1.625s)
[703.727648] [134/134] (349s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[703.821482] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[703.822829] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[703.933578] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: tools_test
results: parsing output: 3/ for test: kms_selftest
results: parsing output: 4/ for test: gem_exec_suspend
results: parsing output: 5/ for test: kms_content_protection
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: gem_spin_batch
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_pm_rpm
results: parsing output: 14/ for test: gem_ctx_exec
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: prime_mmap
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: api_intel_allocator
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: gem_exec_create
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: gem_ctx_bad_destroy
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_atomic_interruptible
results: parsing output: 29/ for test: kms_cdclk
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_selftest
results: parsing output: 35/ for test: syncobj_basic
results: parsing output: 36/ for test: gem_lmem_swapping
results: parsing output: 37/ for test: kms_mmap_write_crc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_ctx_exec
results: parsing output: 42/ for test: kms_atomic
results: parsing output: 43/ for test: gem_set_tiling_vs_gtt
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_getfb
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_basic
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_wait
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: kms_dsc
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_chamelium_hpd
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: prime_vgem
results: parsing output: 64/ for test: gem_exec_capture
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: i915_pm_freq_api
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_chamelium_frames
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_color_pipeline
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap_offset
results: parsing output: 79/ for test: gem_pread
results: parsing output: 80/ for test: kms_joiner
results: parsing output: 81/ for test: i915_drm_fdinfo
results: parsing output: 82/ for test: gem_ccs
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_draw_crc
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_exercise_blt
results: parsing output: 96/ for test: sysfs_heartbeat_interval
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_ctx_shared
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: drm_read
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_pipe_crc_basic
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gen7_exec_parse
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: kms_busy
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: i915_suspend
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_setmode
results: parsing output: 132/ for test: gem_exec_balancer
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.