[45.661568] Initializing watchdogs
[45.661647]   /dev/watchdog0
[45.677848] [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]
[45.683525] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.686067] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[45.687988] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[45.786620] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[45.787980] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[45.897500] [002/134] (960s left) gem_exec_params (secure-non-master)
[45.935549] Starting subtest: secure-non-master
[45.936902] Subtest secure-non-master: SKIP (0.000s)
[46.067799] [003/134] (960s left) tools_test (tools_test)
[46.102627] Starting subtest: tools_test
[46.174772] Subtest tools_test: SUCCESS (0.076s)
[46.243553] [004/134] (960s left) kms_selftest (drm_cmdline_parser)
[46.275497] Starting subtest: drm_cmdline_parser
[46.284090] Starting dynamic subtest: drm_test_cmdline_force_d_only
[46.390308] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.106s)
[46.401180] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[46.478504] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.087s)
[46.489850] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[46.582610] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.104s)
[46.594782] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[46.661946] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.077s)
[46.675265] Starting dynamic subtest: drm_test_cmdline_force_e_only
[46.751202] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.089s)
[46.763497] Starting dynamic subtest: drm_test_cmdline_res
[46.872979] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.121s)
[46.885179] Starting dynamic subtest: drm_test_cmdline_res_vesa
[46.958581] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.085s)
[46.970027] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[47.075583] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.116s)
[47.087535] Starting dynamic subtest: drm_test_cmdline_res_rblank
[47.188666] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.112s)
[47.201196] Starting dynamic subtest: drm_test_cmdline_res_bpp
[47.304964] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.114s)
[47.317130] Starting dynamic subtest: drm_test_cmdline_res_refresh
[47.424679] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.120s)
[47.437075] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[47.520930] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.095s)
[47.532993] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[47.633820] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.112s)
[47.647042] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[47.722078] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.087s)
[47.734733] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[47.802322] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.079s)
[47.815642] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[47.887242] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.085s)
[47.900069] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[47.976258] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.088s)
[47.988753] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[48.086763] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.109s)
[48.099384] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[48.193797] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.107s)
[48.207062] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[48.294675] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.100s)
[48.305900] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[48.377744] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.082s)
[48.387945] Starting dynamic subtest: drm_test_cmdline_name
[48.465854] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.086s)
[48.478165] Starting dynamic subtest: drm_test_cmdline_name_bpp
[48.558081] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.092s)
[48.570348] Starting dynamic subtest: drm_test_cmdline_name_option
[48.647899] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.089s)
[48.661229] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[48.710883] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.062s)
[48.723824] Starting dynamic subtest: drm_test_cmdline_rotate_0
[48.785774] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.074s)
[48.798899] Starting dynamic subtest: drm_test_cmdline_rotate_90
[48.864877] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.078s)
[48.877498] Starting dynamic subtest: drm_test_cmdline_rotate_180
[48.981855] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.116s)
[48.994153] Starting dynamic subtest: drm_test_cmdline_rotate_270
[49.066988] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.084s)
[49.080033] Starting dynamic subtest: drm_test_cmdline_hmirror
[49.150945] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.083s)
[49.163743] Starting dynamic subtest: drm_test_cmdline_vmirror
[49.243373] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.091s)
[49.256188] Starting dynamic subtest: drm_test_cmdline_margin_options
[49.345781] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.103s)
[49.358703] Starting dynamic subtest: drm_test_cmdline_multiple_options
[49.450909] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.104s)
[49.461090] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[49.558879] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.107s)
[49.567900] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[49.660079] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.100s)
[49.667645] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[49.733033] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.072s)
[49.743893] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[49.797951] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.064s)
[49.807307] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[49.901768] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.103s)
[49.907901] Starting dynamic subtest: drm_test_cmdline_invalid
[49.991802] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.090s)
[49.996829] Starting dynamic subtest: drm_test_cmdline_tv_options
[50.097920] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.104s)
[50.098824] Subtest drm_cmdline_parser: SUCCESS (3.822s)
[50.253159] [005/134] (956s left) gem_exec_suspend (basic-s0)
[50.294678] Starting subtest: basic-S0
[50.295370] Starting dynamic subtest: smem
[68.332034] Dynamic subtest smem: SUCCESS (2.872s)
[68.333036] Subtest basic-S0: SUCCESS (2.873s)
[77.563264] [006/134] (937s left) kms_content_protection (uevent)
[77.665781] Starting subtest: uevent
[77.679023] Subtest uevent: SKIP (0.012s)
[77.770494] [007/134] (937s left) gem_eio (in-flight-suspend)
[77.812195] Starting subtest: in-flight-suspend
[114.846094] Subtest in-flight-suspend: SUCCESS (7.620s)
[122.978084] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[123.014967] [008/134] (900s left) gem_spin_batch (resubmit-all)
[123.066216] Starting subtest: resubmit-all
[123.066892] Starting dynamic subtest: rcs0
[123.071084] Dynamic subtest rcs0: SUCCESS (0.005s)
[123.078041] Starting dynamic subtest: bcs0
[123.078735] Dynamic subtest bcs0: SUCCESS (0.003s)
[123.085696] Starting dynamic subtest: vcs0
[123.086368] Dynamic subtest vcs0: SUCCESS (0.003s)
[123.092223] Starting dynamic subtest: vcs1
[123.092881] Dynamic subtest vcs1: SUCCESS (0.003s)
[123.098405] Starting dynamic subtest: vecs0
[123.099091] Dynamic subtest vecs0: SUCCESS (0.003s)
[123.099735] Subtest resubmit-all: SUCCESS (0.017s)
[123.264128] [009/134] (900s left) kms_psr (psr-cursor-plane-onoff)
[123.350620] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[123.388791] [010/134] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[123.476877] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[123.478247] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[123.581722] [011/134] (900s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[123.668826] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[123.670174] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[123.784683] [012/134] (899s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[123.872736] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[123.907186] [013/134] (899s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[123.996068] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[124.033131] [014/134] (899s left) kms_pm_rpm (basic-pci-d3-state)
[125.460904] Starting subtest: basic-pci-d3-state
[126.771141] Subtest basic-pci-d3-state: SUCCESS (1.311s)
[126.891981] [015/134] (896s left) gem_ctx_exec (basic-norecovery)
[126.925517] Starting subtest: basic-norecovery
[126.939628] Subtest basic-norecovery: SUCCESS (0.014s)
[127.065622] [016/134] (896s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[127.164765] Starting subtest: protected-encrypted-src-copy-not-readible
[127.251466] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.087s)
[127.426868] [017/134] (896s left) kms_flip (absolute-wf_vblank)
[127.510772] Starting subtest: absolute-wf_vblank
[127.512968] Starting dynamic subtest: A-HDMI-A1
[135.207326] Dynamic subtest A-HDMI-A1: SUCCESS (7.677s)
[135.213736] Starting dynamic subtest: B-HDMI-A1
[142.873601] Dynamic subtest B-HDMI-A1: SUCCESS (7.655s)
[142.880519] Starting dynamic subtest: C-HDMI-A1
[150.508134] Dynamic subtest C-HDMI-A1: SUCCESS (7.659s)
[150.515533] Starting dynamic subtest: D-HDMI-A1
[158.190302] Dynamic subtest D-HDMI-A1: SUCCESS (7.656s)
[158.191052] Subtest absolute-wf_vblank: SUCCESS (30.656s)
[158.323450] [018/134] (865s left) prime_mmap (test_refcounting)
[158.356570] Starting subtest: test_refcounting
[158.357304] Starting dynamic subtest: test_refcounting-smem
[158.358731] Dynamic subtest test_refcounting-smem: SUCCESS (0.002s)
[158.359413] Subtest test_refcounting: SUCCESS (0.002s)
[158.467810] [019/134] (865s left) gem_exec_schedule (pi-common)
[158.633483] Starting subtest: pi-common
[158.634409] Starting dynamic subtest: rcs0
[158.669274] Dynamic subtest rcs0: SUCCESS (0.036s)
[158.676215] Starting dynamic subtest: bcs0
[158.696748] Dynamic subtest bcs0: SUCCESS (0.027s)
[158.703893] Starting dynamic subtest: vcs0
[158.720464] Dynamic subtest vcs0: SUCCESS (0.023s)
[158.727675] Starting dynamic subtest: vcs1
[158.745218] Dynamic subtest vcs1: SUCCESS (0.024s)
[158.752825] Starting dynamic subtest: vecs0
[158.768377] Dynamic subtest vecs0: SUCCESS (0.023s)
[158.769183] Subtest pi-common: SUCCESS (0.135s)
[158.948096] [020/134] (865s left) perf (unprivileged-single-ctx-counters)
[159.051261] Starting subtest: unprivileged-single-ctx-counters
[159.052682] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[159.087366] [021/134] (865s left) api_intel_allocator (fork-simple-stress-signal)
[159.119198] Starting subtest: fork-simple-stress-signal
[164.534337] Subtest fork-simple-stress-signal: SUCCESS (5.415s)
[164.659970] [022/134] (859s left) kms_flip (flip-vs-panning-vs-hang)
[164.746670] Starting subtest: flip-vs-panning-vs-hang
[164.747383] Starting dynamic subtest: A-HDMI-A1
[204.439711] Dynamic subtest A-HDMI-A1: SUCCESS (39.678s)
[204.446045] Starting dynamic subtest: D-HDMI-A1
[243.351849] Dynamic subtest D-HDMI-A1: SUCCESS (38.897s)
[243.352714] Subtest flip-vs-panning-vs-hang: SUCCESS (78.578s)
[243.555766] [023/134] (780s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[243.648347] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[243.687803] [024/134] (780s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[243.721286] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[243.722030] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[243.809771] [025/134] (780s left) gem_exec_create (basic)
[243.849156] Starting subtest: basic
[243.849840] Starting dynamic subtest: smem
[245.893872] Dynamic subtest smem: SUCCESS (2.045s)
[245.894556] Subtest basic: SUCCESS (2.045s)
[246.090583] [026/134] (778s left) gem_ctx_persistence (smoketest)
[246.128322] Starting subtest: smoketest
[284.510955] Subtest smoketest: SUCCESS (38.382s)
[284.596302] [027/134] (739s left) gem_ctx_bad_destroy (invalid-pad)
[284.628635] Starting subtest: invalid-pad
[284.629314] Subtest invalid-pad: SUCCESS (0.000s)
[284.709945] [028/134] (739s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[284.796646] Starting subtest: cursorA-vs-flipB-legacy
[284.798694] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[284.881700] [029/134] (739s left) kms_atomic_interruptible (legacy-setmode)
[284.968140] Starting subtest: legacy-setmode
[284.968802] Starting dynamic subtest: pipe-A-HDMI-A-1
[291.174800] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.206s)
[291.175527] Subtest legacy-setmode: SUCCESS (6.207s)
[291.348273] [030/134] (733s left) kms_cdclk (mode-transition)
[291.382388] Subtest mode-transition: SKIP (0.000s)
[291.426351] [031/134] (733s left) kms_big_fb (linear-8bpp-rotate-270)
[291.520188] Starting subtest: linear-8bpp-rotate-270
[291.593077] Subtest linear-8bpp-rotate-270: SKIP (0.072s)
[291.728110] [032/134] (732s left) perf_pmu (faulting-read)
[291.762867] Starting subtest: faulting-read
[291.763569] Starting dynamic subtest: gtt
[291.765135] Dynamic subtest gtt: SUCCESS (0.002s)
[291.772124] Starting dynamic subtest: wb
[291.772796] Dynamic subtest wb: SUCCESS (0.001s)
[291.779695] Starting dynamic subtest: wc
[291.780413] Dynamic subtest wc: SUCCESS (0.000s)
[291.787478] Starting dynamic subtest: uc
[291.788163] Dynamic subtest uc: SUCCESS (0.000s)
[291.788829] Subtest faulting-read: SUCCESS (0.004s)
[291.875866] [033/134] (732s left) kms_psr (fbc-psr2-primary-render)
[291.960789] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[292.000761] [034/134] (732s left) gem_exec_schedule (deep)
[292.165884] Starting subtest: deep
[292.166805] Starting dynamic subtest: rcs0
[300.035832] Dynamic subtest rcs0: SUCCESS (7.862s)
[300.043257] Starting dynamic subtest: bcs0
[308.172709] Dynamic subtest bcs0: SUCCESS (8.136s)
[308.182342] Starting dynamic subtest: vcs0
[316.361129] Dynamic subtest vcs0: SUCCESS (8.187s)
[316.368880] Starting dynamic subtest: vcs1
[324.545120] Dynamic subtest vcs1: SUCCESS (8.184s)
[324.552842] Starting dynamic subtest: vecs0
[332.704121] Dynamic subtest vecs0: SUCCESS (8.159s)
[332.704927] Subtest deep: SUCCESS (40.531s)
[333.290661] [035/134] (691s left) kms_selftest (drm_plane_helper)
[333.322534] Starting subtest: drm_plane_helper
[333.336165] Starting dynamic subtest: drm_test_check_plane_state
[333.430996] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.095s)
[333.447738] Starting dynamic subtest: drm_test_check_invalid_plane_state
[333.528064] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.093s)
[333.529169] Subtest drm_plane_helper: SUCCESS (0.204s)
[333.703110] [036/134] (691s left) syncobj_basic (bad-pad-fd-to-handle)
[333.735056] Starting subtest: bad-pad-fd-to-handle
[333.735735] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[333.825284] [037/134] (690s left) gem_lmem_swapping (parallel-random-engines)
[333.859838] Subtest parallel-random-engines: SKIP (0.000s)
[333.897054] [038/134] (690s left) kms_mmap_write_crc (main)
[333.986830] Starting subtest: main
[333.988399] Starting dynamic subtest: pipe-A-HDMI-A-1
[335.443338] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.455s)
[335.444011] Subtest main: SUCCESS (1.456s)
[335.593113] [039/134] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[335.687896] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[335.689241] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[335.792698] [040/134] (689s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[335.877812] Starting subtest: addfb25-yf-tiled-legacy
[335.878517] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[335.994846] [041/134] (688s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[336.082207] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[336.083574] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[336.193335] [042/134] (688s left) gem_ctx_exec (basic)
[336.225951] Starting subtest: basic
[336.228393] Subtest basic: SUCCESS (0.002s)
[336.344352] [043/134] (688s left) kms_atomic (test-only)
[336.429630] Starting subtest: test-only
[336.488277] Starting dynamic subtest: pipe-A-HDMI-A-1
[336.883866] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.396s)
[336.884640] Subtest test-only: SUCCESS (0.455s)
[337.048925] [044/134] (687s left) gem_set_tiling_vs_gtt
[337.537089] [045/134] (687s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[337.635364] Starting subtest: yf-tiled-16bpp-rotate-0
[337.636713] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[337.754420] [046/134] (687s left) kms_getfb (getfb2-handle-zero)
[337.840191] Starting subtest: getfb2-handle-zero
[337.840889] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[337.942074] [047/134] (687s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[337.974683] Starting subtest: single-wait-all-for-submit-available-submitted
[337.975370] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[338.052173] [048/134] (687s left) gem_exec_reloc (basic-wc-cpu)
[338.088815] Starting subtest: basic-wc-cpu
[338.094226] Subtest basic-wc-cpu: SUCCESS (0.005s)
[338.215355] [049/134] (687s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[338.305007] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[338.306399] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[338.418518] [050/134] (686s left) gem_basic (multigpu-create-close)
[338.450832] Starting subtest: multigpu-create-close
[338.452188] Subtest multigpu-create-close: SKIP (0.000s)
[338.535889] [051/134] (686s left) kms_frontbuffer_tracking (fbc-suspend)
[338.625752] Starting subtest: fbc-suspend
[375.002477] Subtest fbc-suspend: SUCCESS (5.152s)
[381.196669] [052/134] (650s left) gem_wait (wait)
[381.241870] Starting subtest: wait
[381.242660] Starting dynamic subtest: all-engines
[382.273975] Dynamic subtest all-engines: SUCCESS (1.031s)
[382.285687] Starting dynamic subtest: rcs0
[383.299233] Dynamic subtest rcs0: SUCCESS (1.023s)
[383.309748] Starting dynamic subtest: bcs0
[384.330069] Dynamic subtest bcs0: SUCCESS (1.029s)
[384.340616] Starting dynamic subtest: vcs0
[385.353075] Dynamic subtest vcs0: SUCCESS (1.019s)
[385.363443] Starting dynamic subtest: vcs1
[386.376051] Dynamic subtest vcs1: SUCCESS (1.023s)
[386.386451] Starting dynamic subtest: vecs0
[387.405155] Dynamic subtest vecs0: SUCCESS (1.027s)
[387.406204] Subtest wait: SUCCESS (6.160s)
[387.621472] [053/134] (643s left) gem_exec_reloc (basic-wc-active)
[387.658314] Starting subtest: basic-wc-active
[387.789074] Subtest basic-wc-active: SUCCESS (0.122s)
[387.927729] [054/134] (643s left) kms_pm_rpm (pc8-residency)
[389.319065] Starting subtest: pc8-residency
[389.320932] Subtest pc8-residency: SKIP (0.000s)
[389.505363] [055/134] (641s left) kms_dsc (dsc-with-bpc-formats)
[389.589738] Starting subtest: dsc-with-bpc-formats
[389.622950] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[389.663544] [056/134] (641s left) kms_psr (pr-cursor-plane-move)
[389.747977] Subtest pr-cursor-plane-move: SKIP (0.000s)
[389.791497] [057/134] (641s left) kms_vblank (ts-continuation-dpms-suspend)
[389.874675] Starting subtest: ts-continuation-dpms-suspend
[389.876300] Starting dynamic subtest: pipe-A-HDMI-A-1
[406.884562] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.412s)
[406.896925] Starting dynamic subtest: pipe-D-HDMI-A-1
[423.894727] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.407s)
[423.895523] Subtest ts-continuation-dpms-suspend: SUCCESS (2.826s)
[433.096372] [058/134] (607s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[433.138659] Starting subtest: multi-wait-available-unsubmitted-signaled
[433.139381] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[433.232562] [059/134] (607s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[433.317138] Starting subtest: basic-flip-before-cursor-legacy
[433.842752] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.525s)
[434.001976] [060/134] (606s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[434.141537] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[434.238766] [061/134] (606s left) gem_exec_params (invalid-flag)
[434.277917] Starting subtest: invalid-flag
[434.278676] Subtest invalid-flag: SUCCESS (0.000s)
[434.396567] [062/134] (606s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[434.483973] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[434.485310] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[434.593427] [063/134] (606s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[434.627359] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[434.628119] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[434.708300] [064/134] (606s left) prime_vgem (wait)
[434.770684] Starting subtest: wait
[434.771409] Starting dynamic subtest: rcs0
[434.819300] Dynamic subtest rcs0: SUCCESS (0.048s)
[434.829728] Starting dynamic subtest: bcs0
[434.842982] Dynamic subtest bcs0: SUCCESS (0.023s)
[434.851747] Starting dynamic subtest: vcs0
[434.869257] Dynamic subtest vcs0: SUCCESS (0.025s)
[434.876824] Starting dynamic subtest: vcs1
[434.898602] Dynamic subtest vcs1: SUCCESS (0.028s)
[434.907657] Starting dynamic subtest: vecs0
[434.927346] Dynamic subtest vecs0: SUCCESS (0.028s)
[434.928280] Subtest wait: SUCCESS (0.157s)
[435.072193] [065/134] (605s left) gem_exec_capture (capture)
[435.107810] Starting subtest: capture
[435.108510] Starting dynamic subtest: rcs0-smem
[436.386042] Dynamic subtest rcs0-smem: SUCCESS (1.271s)
[436.393509] Starting dynamic subtest: bcs0-smem
[437.658561] Dynamic subtest bcs0-smem: SUCCESS (1.270s)
[437.665962] Starting dynamic subtest: vcs0-smem
[438.930583] Dynamic subtest vcs0-smem: SUCCESS (1.272s)
[438.937858] Starting dynamic subtest: vcs1-smem
[440.202100] Dynamic subtest vcs1-smem: SUCCESS (1.271s)
[440.209387] Starting dynamic subtest: vecs0-smem
[441.473900] Dynamic subtest vecs0-smem: SUCCESS (1.271s)
[441.474574] Subtest capture: SUCCESS (6.359s)
[441.605242] [066/134] (599s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[441.697800] Starting subtest: cursor-rapid-movement-512x512
[441.699190] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[441.822080] [067/134] (599s left) kms_flip (2x-flip-vs-wf_vblank)
[441.906935] Starting subtest: 2x-flip-vs-wf_vblank
[441.916181] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s)
[442.010275] [068/134] (599s left) i915_pm_freq_api (freq-suspend)
[442.046520] Subtest freq-suspend: SKIP (0.000s)
[442.084339] [069/134] (599s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[442.175184] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[442.176518] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[442.296392] [070/134] (598s left) kms_chamelium_frames (hdmi-aspect-ratio)
[442.431307] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[442.522922] [071/134] (598s left) kms_cursor_crc (cursor-sliding-max-size)
[442.614663] Starting subtest: cursor-sliding-max-size
[442.616772] Subtest cursor-sliding-max-size: SKIP (0.000s)
[442.744096] [072/134] (598s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[442.830787] Starting subtest: plane-ctm3x4-lut1d
[442.845524] Starting dynamic subtest: pipe-A-HDMI-A-1
[443.011094] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.166s)
[443.156312] Starting dynamic subtest: pipe-B-HDMI-A-1
[443.305664] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.156s)
[443.450415] Starting dynamic subtest: pipe-C-HDMI-A-1
[443.592635] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.148s)
[443.749200] Starting dynamic subtest: pipe-D-HDMI-A-1
[443.888448] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.148s)
[443.964572] Subtest plane-ctm3x4-lut1d: SUCCESS (1.134s)
[444.084683] [073/134] (597s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[444.175125] Starting subtest: psr-1p-pri-indfb-multidraw
[444.176437] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[444.283143] [074/134] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[444.371144] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[444.372508] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[444.493086] [075/134] (596s left) syncobj_timeline (invalid-query-illegal-handle)
[444.525843] Starting subtest: invalid-query-illegal-handle
[444.526589] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[444.603659] [076/134] (596s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[444.686333] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[444.688146] Starting dynamic subtest: pipe-A-HDMI-A-1
[444.695022] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[444.705461] Starting dynamic subtest: pipe-B-HDMI-A-1
[444.712232] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[444.722152] Starting dynamic subtest: pipe-C-HDMI-A-1
[444.728924] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[444.739037] Starting dynamic subtest: pipe-D-HDMI-A-1
[444.745741] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[444.747082] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.009s)
[444.949210] [077/134] (596s left) kms_addfb_basic (too-high)
[445.034543] Starting subtest: too-high
[445.035628] Subtest too-high: SUCCESS (0.001s)
[445.134604] [078/134] (596s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[445.223004] Starting subtest: psr-rgb565-draw-mmap-gtt
[445.224369] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[445.337327] [079/134] (596s left) gem_mmap_offset (mmap-unmap)
[445.376744] Starting subtest: mmap-unmap
[445.377450] Starting dynamic subtest: smem0
[476.327740] Dynamic subtest smem0: SUCCESS (30.955s)
[476.328547] Subtest mmap-unmap: SUCCESS (30.956s)
[476.451251] [080/134] (565s left) gem_pread (exhaustion)
[476.482264] Starting subtest: exhaustion
[480.343059] Subtest exhaustion: SUCCESS (3.850s)
[481.188723] [081/134] (560s left) kms_joiner (invalid-modeset-ultra-joiner)
[481.276319] Starting subtest: invalid-modeset-ultra-joiner
[481.277637] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[481.360332] [082/134] (560s left) i915_drm_fdinfo (basics)
[481.395987] Starting subtest: basics
[481.396691] Subtest basics: SUCCESS (0.000s)
[481.477080] [083/134] (560s left) gem_ccs (ctrl-surf-copy-new-ctx)
[481.514535] Starting subtest: ctrl-surf-copy-new-ctx
[481.515945] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[481.615707] [084/134] (560s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[481.700249] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[481.718989] Starting dynamic subtest: pipe-A-plane-0
[482.194224] Dynamic subtest pipe-A-plane-0: SUCCESS (0.475s)
[482.210161] Starting dynamic subtest: pipe-A-plane-3
[482.586208] Dynamic subtest pipe-A-plane-3: SUCCESS (0.390s)
[482.603226] Starting dynamic subtest: pipe-A-plane-5
[482.869450] Dynamic subtest pipe-A-plane-5: SUCCESS (0.281s)
[482.886736] Starting dynamic subtest: pipe-A-plane-7
[482.888139] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[483.028770] Starting dynamic subtest: pipe-B-plane-0
[483.438446] Dynamic subtest pipe-B-plane-0: SUCCESS (0.417s)
[483.455425] Starting dynamic subtest: pipe-B-plane-3
[483.855215] Dynamic subtest pipe-B-plane-3: SUCCESS (0.415s)
[483.873630] Starting dynamic subtest: pipe-B-plane-5
[484.130618] Dynamic subtest pipe-B-plane-5: SUCCESS (0.273s)
[484.147927] Starting dynamic subtest: pipe-B-plane-7
[484.149380] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[484.205645] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.506s)
[484.384495] [085/134] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[484.484246] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[484.485600] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[484.597249] [086/134] (557s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[484.682842] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[484.685114] Starting dynamic subtest: pipe-A-valid-mode
[485.911906] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.227s)
[485.912592] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.229s)
[486.060127] [087/134] (555s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[486.158282] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[486.159647] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[486.265562] [088/134] (555s left) kms_draw_crc (fill-fb)
[486.351599] Starting subtest: fill-fb
[486.572133] Subtest fill-fb: SUCCESS (0.221s)
[486.666646] [089/134] (555s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[486.759540] Starting subtest: y-tiled-8bpp-rotate-0
[487.739234] Subtest y-tiled-8bpp-rotate-0: SUCCESS (0.979s)
[487.873613] [090/134] (554s left) gem_render_copy (yf-tiled-to-vebox-linear)
[487.912303] Starting subtest: yf-tiled-to-vebox-linear
[487.913024] Starting dynamic subtest: smem
[487.974631] Dynamic subtest smem: SUCCESS (0.063s)
[487.975427] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.064s)
[488.152432] [091/134] (553s left) syncobj_wait (invalid-reset-illegal-handle)
[488.186186] Starting subtest: invalid-reset-illegal-handle
[488.186873] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[488.280095] [092/134] (553s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[488.370547] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[488.371897] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[488.488278] [093/134] (553s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[488.584011] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[488.585505] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[488.680865] [094/134] (553s left) api_intel_bb (full-batch)
[488.714660] Starting subtest: full-batch
[488.717266] Subtest full-batch: SUCCESS (0.003s)
[488.847323] [095/134] (553s left) kms_psr (fbc-psr-basic)
[488.932162] Subtest fbc-psr-basic: SKIP (0.000s)
[488.979101] [096/134] (553s left) gem_exercise_blt (fast-copy-emit)
[489.017645] Starting subtest: fast-copy-emit
[489.018433] Starting dynamic subtest: linear-smem-smem-emit
[489.036194] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.019s)
[489.047040] Starting dynamic subtest: ymajor-smem-smem-emit
[489.057406] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.020s)
[489.068202] Starting dynamic subtest: tile4-smem-smem-emit
[489.078099] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.019s)
[489.088800] Starting dynamic subtest: tile64-smem-smem-emit
[489.099486] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.020s)
[489.100269] Subtest fast-copy-emit: SUCCESS (0.084s)
[489.241354] [097/134] (553s left) sysfs_heartbeat_interval (mixed)
[489.277011] Starting subtest: mixed
[489.278733] Starting dynamic subtest: vecs0
[494.443633] Dynamic subtest vecs0: SUCCESS (5.165s)
[494.454652] Starting dynamic subtest: vcs0
[499.611499] Dynamic subtest vcs0: SUCCESS (5.165s)
[499.624794] Starting dynamic subtest: bcs0
[504.797643] Dynamic subtest bcs0: SUCCESS (5.183s)
[504.809040] Starting dynamic subtest: rcs0
[510.011713] Dynamic subtest rcs0: SUCCESS (5.211s)
[510.024719] Starting dynamic subtest: vcs1
[515.206790] Dynamic subtest vcs1: SUCCESS (5.192s)
[515.207967] Subtest mixed: SUCCESS (25.929s)
[515.296243] [098/134] (527s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[515.382781] Starting subtest: cursor-vs-flip-legacy
[544.981545] Subtest cursor-vs-flip-legacy: SUCCESS (29.599s)
[545.131910] [099/134] (497s left) gem_exec_schedule (semaphore-resolve)
[545.179017] Starting subtest: semaphore-resolve
[545.196300] Subtest semaphore-resolve: SUCCESS (0.017s)
[545.512640] [100/134] (496s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[545.602746] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[545.604122] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[545.726337] [101/134] (496s left) kms_cursor_legacy (torture-bo)
[545.812942] Starting subtest: torture-bo
[545.813648] Starting dynamic subtest: pipe-A
[551.421344] Dynamic subtest pipe-A: SUCCESS (5.496s)
[551.430931] Starting dynamic subtest: pipe-B
[556.998175] Dynamic subtest pipe-B: SUCCESS (5.636s)
[557.005768] Starting dynamic subtest: pipe-C
[562.504476] Dynamic subtest pipe-C: SUCCESS (5.505s)
[562.518680] Starting dynamic subtest: pipe-D
[568.111653] Dynamic subtest pipe-D: SUCCESS (5.605s)
[568.121214] Starting dynamic subtest: all-pipes
[573.726075] Dynamic subtest all-pipes: SUCCESS (5.613s)
[573.727044] Subtest torture-bo: SUCCESS (27.880s)
[573.770349] [102/134] (468s left) gem_ctx_shared (q-independent)
[573.810953] Starting subtest: Q-independent
[573.811696] Starting dynamic subtest: rcs0
[573.832698] Dynamic subtest rcs0: SUCCESS (0.021s)
[573.842012] Starting dynamic subtest: bcs0
[573.851808] Dynamic subtest bcs0: SUCCESS (0.018s)
[573.861441] Starting dynamic subtest: vcs0
[573.871870] Dynamic subtest vcs0: SUCCESS (0.019s)
[573.881172] Starting dynamic subtest: vcs1
[573.892801] Dynamic subtest vcs1: SUCCESS (0.020s)
[573.902319] Starting dynamic subtest: vecs0
[573.911637] Dynamic subtest vecs0: SUCCESS (0.018s)
[573.912640] Subtest Q-independent: SUCCESS (0.101s)
[574.104208] [103/134] (468s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[574.565937] Starting subtest: syncobj-timeline-invalid-wait
[574.566944] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[574.764778] [104/134] (467s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[574.802759] Starting subtest: y-tiled-ccs-to-x-tiled
[574.803437] Starting dynamic subtest: smem
[574.913168] Dynamic subtest smem: SUCCESS (0.110s)
[574.913892] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.111s)
[575.100350] [105/134] (467s left) drm_read (short-buffer-wakeup)
[575.207272] Starting subtest: short-buffer-wakeup
[607.429693] Subtest short-buffer-wakeup: SUCCESS (32.214s)
[607.550782] [106/134] (435s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[607.640360] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[607.641057] Starting dynamic subtest: pipe-A-HDMI-A-1
[607.693775] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.053s)
[607.760030] Starting dynamic subtest: pipe-B-HDMI-A-1
[607.923690] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.171s)
[607.965625] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.325s)
[608.113791] [107/134] (434s left) syncobj_timeline (device-submit-unordered)
[608.148956] Starting subtest: device-submit-unordered
[608.149706] Subtest device-submit-unordered: SUCCESS (0.000s)
[608.231187] [108/134] (434s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[608.317253] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[608.317927] Starting dynamic subtest: pipe-A-HDMI-A-1
[608.334414] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[608.341873] Starting dynamic subtest: pipe-B-HDMI-A-1
[608.358635] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[608.366032] Starting dynamic subtest: pipe-C-HDMI-A-1
[608.382769] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[608.390468] Starting dynamic subtest: pipe-D-HDMI-A-1
[608.408156] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[608.409482] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.014s)
[608.567588] [109/134] (434s left) kms_pipe_crc_basic (nonblocking-crc)
[608.653727] Starting subtest: nonblocking-crc
[608.654750] Starting dynamic subtest: pipe-A-HDMI-A-1
[609.011248] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.356s)
[609.022222] Starting dynamic subtest: pipe-B-HDMI-A-1
[609.357528] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.343s)
[609.367993] Starting dynamic subtest: pipe-C-HDMI-A-1
[609.692151] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.331s)
[609.701470] Starting dynamic subtest: pipe-D-HDMI-A-1
[610.030960] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.337s)
[610.031660] Subtest nonblocking-crc: SUCCESS (1.378s)
[610.167339] [110/134] (432s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[610.263220] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[611.353178] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (1.090s)
[611.509508] [111/134] (431s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[611.604734] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[612.817582] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.214s)
[612.961434] [112/134] (430s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[613.051358] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[613.067359] Starting dynamic subtest: pipe-A-plane-0
[613.068742] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[613.076189] Starting dynamic subtest: pipe-A-plane-3
[613.077579] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[613.084951] Starting dynamic subtest: pipe-A-plane-5
[613.086353] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[613.093585] Starting dynamic subtest: pipe-A-plane-7
[613.094941] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[613.218205] Starting dynamic subtest: pipe-B-plane-0
[613.219590] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[613.229027] Starting dynamic subtest: pipe-B-plane-3
[613.230484] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[613.240005] Starting dynamic subtest: pipe-B-plane-5
[613.241437] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[613.250784] Starting dynamic subtest: pipe-B-plane-7
[613.252253] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[613.283256] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.231s)
[613.428619] [113/134] (429s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[613.515927] Starting subtest: plane-downscale-factor-0-5-with-rotation
[613.517060] Starting dynamic subtest: pipe-A
[614.623687] Dynamic subtest pipe-A: SKIP (1.106s)
[614.631191] Starting dynamic subtest: pipe-B
[615.764498] Dynamic subtest pipe-B: SKIP (1.139s)
[615.772079] Starting dynamic subtest: pipe-C
[616.897503] Dynamic subtest pipe-C: SKIP (1.133s)
[616.904919] Starting dynamic subtest: pipe-D
[618.019981] Dynamic subtest pipe-D: SKIP (1.121s)
[618.022496] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (4.503s)
[618.209753] [114/134] (424s left) perf_pmu (busy-hang)
[618.256314] Starting subtest: busy-hang
[618.257000] Starting dynamic subtest: rcs0
[619.303000] Dynamic subtest rcs0: SUCCESS (1.046s)
[619.311737] Starting dynamic subtest: bcs0
[620.349814] Dynamic subtest bcs0: SUCCESS (1.043s)
[620.359140] Starting dynamic subtest: vcs0
[621.388763] Dynamic subtest vcs0: SUCCESS (1.037s)
[621.400205] Starting dynamic subtest: vcs1
[622.451168] Dynamic subtest vcs1: SUCCESS (1.060s)
[622.463313] Starting dynamic subtest: vecs0
[623.504075] Dynamic subtest vecs0: SUCCESS (1.050s)
[623.507239] Subtest busy-hang: SUCCESS (5.249s)
[623.599080] [115/134] (419s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[623.686403] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[623.688301] Starting dynamic subtest: pipe-A-HDMI-A-1
[623.694815] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[623.702569] Starting dynamic subtest: pipe-B-HDMI-A-1
[623.709303] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[623.716896] Starting dynamic subtest: pipe-C-HDMI-A-1
[623.723547] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[623.730882] Starting dynamic subtest: pipe-D-HDMI-A-1
[623.737593] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[623.738917] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[623.934447] [116/134] (419s left) kms_cursor_crc (cursor-offscreen-128x42)
[624.024357] Starting subtest: cursor-offscreen-128x42
[624.028718] Starting dynamic subtest: pipe-A-HDMI-A-1
[625.265607] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.237s)
[625.307696] Starting dynamic subtest: pipe-D-HDMI-A-1
[626.518025] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.219s)
[626.518762] Subtest cursor-offscreen-128x42: SUCCESS (2.495s)
[626.671575] [117/134] (416s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[626.761296] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[626.761996] Starting dynamic subtest: pipe-A
[626.892537] Dynamic subtest pipe-A: SUCCESS (0.132s)
[626.901822] Starting dynamic subtest: pipe-B
[627.034907] Dynamic subtest pipe-B: SUCCESS (0.141s)
[627.045905] Starting dynamic subtest: pipe-C
[627.161200] Dynamic subtest pipe-C: SUCCESS (0.125s)
[627.172740] Starting dynamic subtest: pipe-D
[627.287168] Dynamic subtest pipe-D: SUCCESS (0.125s)
[627.287851] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.527s)
[627.482375] [118/134] (415s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[627.576907] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[628.163327] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.586s)
[628.315381] [119/134] (414s left) syncobj_basic (bad-pad-handle-to-fd)
[628.347237] Starting subtest: bad-pad-handle-to-fd
[628.347906] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[628.437841] [120/134] (414s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[628.522354] Starting subtest: cursorA-vs-flipB-atomic-transitions
[628.523680] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[628.609207] [121/134] (414s left) kms_frontbuffer_tracking (psr-2p-rte)
[628.697993] Starting subtest: psr-2p-rte
[628.699324] Subtest psr-2p-rte: SKIP (0.000s)
[628.813976] [122/134] (414s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[628.903249] Starting subtest: psr-shrfb-scaledprimary
[628.904623] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[629.004237] [123/134] (414s left) gen7_exec_parse (cmd-crossing-page)
[629.040538] Subtest cmd-crossing-page: SKIP (0.000s)
[629.086548] [124/134] (414s left) kms_frontbuffer_tracking (fbc-1p-rte)
[629.176424] Starting subtest: fbc-1p-rte
[631.942738] Subtest fbc-1p-rte: SUCCESS (2.768s)
[632.126380] [125/134] (411s left) gem_mmap_wc (write)
[632.159513] Starting subtest: write
[632.192642] Subtest write: SUCCESS (0.034s)
[632.301153] [126/134] (411s left) kms_busy (extended-modeset-hang-newfb)
[632.391449] Starting subtest: extended-modeset-hang-newfb
[632.394333] Starting dynamic subtest: pipe-A
[657.071595] Dynamic subtest pipe-A: SUCCESS (24.677s)
[657.082539] Starting dynamic subtest: pipe-D
[681.136175] Dynamic subtest pipe-D: SUCCESS (24.061s)
[681.136953] Subtest extended-modeset-hang-newfb: SUCCESS (48.746s)
[681.284180] [127/134] (362s left) i915_pm_rpm (gem-evict-pwrite)
[682.684426] Starting subtest: gem-evict-pwrite
[683.967147] Subtest gem-evict-pwrite: SUCCESS (1.283s)
[684.150982] [128/134] (359s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[684.236408] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[684.237127] Starting dynamic subtest: pipe-A-HDMI-A-1
[684.243153] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[684.250816] Starting dynamic subtest: pipe-B-HDMI-A-1
[684.256853] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[684.264342] Starting dynamic subtest: pipe-C-HDMI-A-1
[684.270373] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[684.277743] Starting dynamic subtest: pipe-D-HDMI-A-1
[684.283596] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[684.284270] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.009s)
[684.486380] [129/134] (359s left) i915_suspend (basic-s2idle-without-i915)
[684.518374] Starting subtest: basic-s2idle-without-i915
[702.740435] Subtest basic-s2idle-without-i915: SUCCESS (3.053s)
[710.847112] [130/134] (340s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[710.944570] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[710.946391] Starting dynamic subtest: pipe-A-valid-mode
[711.927516] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.980s)
[711.928258] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (0.982s)
[712.092633] [131/134] (339s left) kms_big_fb (4-tiled-addfb)
[712.189868] Starting subtest: 4-tiled-addfb
[712.191316] Subtest 4-tiled-addfb: SKIP (0.000s)
[712.296978] [132/134] (339s left) kms_setmode (basic-clone-single-crtc)
[712.331013] Starting subtest: basic-clone-single-crtc
[712.333124] Subtest basic-clone-single-crtc: SKIP (0.000s)
[712.410036] [133/134] (339s left) gem_exec_balancer (full-late-pulse)
[712.453448] Starting subtest: full-late-pulse
[714.083662] Subtest full-late-pulse: SUCCESS (1.628s)
[714.288566] [134/134] (337s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[714.383595] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[714.385016] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[714.508287] 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.