[65.862483] Initializing watchdogs [65.862562] /dev/watchdog0 [65.891733] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [65.905569] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [65.910129] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [65.913793] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [67.407205] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [67.410395] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [67.563420] [002/134] (958s left) gem_exec_params (secure-non-master) [67.629459] Starting subtest: secure-non-master [67.632960] Subtest secure-non-master: SKIP (0.000s) [67.831966] [003/134] (958s left) tools_test (tools_test) [67.883447] Starting subtest: tools_test [67.980259] Subtest tools_test: SUCCESS (0.106s) [68.112561] [004/134] (958s left) kms_selftest (drm_cmdline_parser) [68.156639] Starting subtest: drm_cmdline_parser [68.171876] Starting dynamic subtest: drm_test_cmdline_force_d_only [68.249321] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.079s) [68.263516] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [68.340193] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.090s) [68.350042] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [68.429431] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.089s) [68.464720] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [68.514462] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.081s) [68.547067] Starting dynamic subtest: drm_test_cmdline_force_e_only [68.600559] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.085s) [68.630903] Starting dynamic subtest: drm_test_cmdline_res [68.681699] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.080s) [68.713295] Starting dynamic subtest: drm_test_cmdline_res_vesa [68.749233] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.069s) [68.770893] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [68.842367] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.091s) [68.850183] Starting dynamic subtest: drm_test_cmdline_res_rblank [68.938566] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.094s) [68.946646] Starting dynamic subtest: drm_test_cmdline_res_bpp [69.015056] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.078s) [69.026780] Starting dynamic subtest: drm_test_cmdline_res_refresh [69.100282] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.084s) [69.134091] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [69.194895] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.091s) [69.228994] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [69.283264] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.086s) [69.317990] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [69.369261] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.085s) [69.403813] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [69.461255] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.093s) [69.496766] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [69.558646] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.094s) [69.593161] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [69.657240] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.100s) [69.691931] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [69.749557] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.090s) [69.783178] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [69.823654] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.074s) [69.854850] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [69.914748] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.087s) [69.947926] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [69.997705] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.075s) [70.025462] Starting dynamic subtest: drm_test_cmdline_name [70.083436] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.091s) [70.116828] Starting dynamic subtest: drm_test_cmdline_name_bpp [70.154608] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.073s) [70.176518] Starting dynamic subtest: drm_test_cmdline_name_option [70.243841] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.089s) [70.279175] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [70.322492] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.074s) [70.330943] Starting dynamic subtest: drm_test_cmdline_rotate_0 [70.403648] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.083s) [70.411616] Starting dynamic subtest: drm_test_cmdline_rotate_90 [70.494631] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.089s) [70.503170] Starting dynamic subtest: drm_test_cmdline_rotate_180 [70.580583] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.086s) [70.614431] Starting dynamic subtest: drm_test_cmdline_rotate_270 [70.678134] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.092s) [70.710815] Starting dynamic subtest: drm_test_cmdline_hmirror [70.865236] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.187s) [70.873198] Starting dynamic subtest: drm_test_cmdline_vmirror [71.019762] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.154s) [71.027705] Starting dynamic subtest: drm_test_cmdline_margin_options [72.056807] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (1.040s) [72.064959] Starting dynamic subtest: drm_test_cmdline_multiple_options [72.443793] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.387s) [72.453607] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [72.527748] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.086s) [72.535848] Starting dynamic subtest: drm_test_cmdline_extra_and_option [72.605273] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.078s) [72.614030] Starting dynamic subtest: drm_test_cmdline_freestanding_options [72.684681] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.080s) [72.719140] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [72.789889] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.103s) [72.819610] Starting dynamic subtest: drm_test_cmdline_panel_orientation [72.869637] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.079s) [72.878535] Starting dynamic subtest: drm_test_cmdline_invalid [72.988241] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.115s) [73.018411] Starting dynamic subtest: drm_test_cmdline_tv_options [73.076211] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.089s) [73.079226] Subtest drm_cmdline_parser: SUCCESS (4.933s) [73.307094] [005/134] (953s left) gem_exec_suspend (basic-s0) [73.362674] Starting subtest: basic-S0 [73.363979] Starting dynamic subtest: smem [93.704584] Dynamic subtest smem: SUCCESS (5.248s) [93.713899] Starting dynamic subtest: lmem0 [113.714781] Dynamic subtest lmem0: SUCCESS (5.189s) [113.716536] Subtest basic-S0: SUCCESS (10.438s) [119.097044] [006/134] (912s left) kms_content_protection (uevent) [120.595209] Starting subtest: uevent [120.607173] Subtest uevent: SKIP (0.005s) [120.820502] [007/134] (911s left) gem_eio (in-flight-suspend) [121.009563] Starting subtest: in-flight-suspend [164.129621] Subtest in-flight-suspend: SUCCESS (17.371s) [170.708154] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true [170.710836] [008/134] (866s left) gem_spin_batch (resubmit-all) [170.772892] Starting subtest: resubmit-all [170.774565] Starting dynamic subtest: rcs0 [170.798052] Dynamic subtest rcs0: SUCCESS (0.024s) [170.812051] Starting dynamic subtest: bcs0 [170.813843] Dynamic subtest bcs0: SUCCESS (0.003s) [170.825958] Starting dynamic subtest: vcs0 [170.827745] Dynamic subtest vcs0: SUCCESS (0.003s) [170.839888] Starting dynamic subtest: vcs1 [170.841852] Dynamic subtest vcs1: SUCCESS (0.003s) [170.854043] Starting dynamic subtest: vecs0 [170.857813] Dynamic subtest vecs0: SUCCESS (0.003s) [170.859665] Subtest resubmit-all: SUCCESS (0.037s) [171.102508] [009/134] (866s left) kms_psr (psr-cursor-plane-onoff) [172.645820] Subtest psr-cursor-plane-onoff: SKIP (0.000s) [172.722601] [010/134] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [174.258202] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [174.261411] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [174.514178] [011/134] (862s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [176.040668] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [176.043573] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [176.306748] [012/134] (861s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [177.852189] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [177.927152] [013/134] (859s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [179.444240] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [179.517926] [014/134] (858s left) kms_pm_rpm (basic-pci-d3-state) [183.863599] Starting subtest: basic-pci-d3-state [185.055699] Subtest basic-pci-d3-state: SUCCESS (1.183s) [186.011851] [015/134] (851s left) gem_ctx_exec (basic-norecovery) [186.059585] Starting subtest: basic-norecovery [186.337841] Subtest basic-norecovery: SUCCESS (0.276s) [186.530492] [016/134] (851s left) gem_pxp (protected-encrypted-src-copy-not-readible) [189.103578] Starting subtest: protected-encrypted-src-copy-not-readible [189.106481] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s) [189.242040] [017/134] (848s left) kms_flip (absolute-wf_vblank) [190.732925] Starting subtest: absolute-wf_vblank [190.739496] Starting dynamic subtest: A-HDMI-A4 [198.495932] Dynamic subtest A-HDMI-A4: SUCCESS (7.738s) [198.509879] Starting dynamic subtest: B-HDMI-A4 [206.184552] Dynamic subtest B-HDMI-A4: SUCCESS (7.680s) [206.196516] Starting dynamic subtest: C-HDMI-A4 [213.873938] Dynamic subtest C-HDMI-A4: SUCCESS (7.686s) [213.885996] Starting dynamic subtest: D-HDMI-A4 [221.562370] Dynamic subtest D-HDMI-A4: SUCCESS (7.684s) [221.563933] Subtest absolute-wf_vblank: SUCCESS (30.798s) [221.841058] [018/134] (816s left) prime_mmap (test_refcounting) [221.886720] Starting subtest: test_refcounting [221.888437] Starting dynamic subtest: test_refcounting-smem [221.944721] Dynamic subtest test_refcounting-smem: SUCCESS (0.060s) [221.956105] Starting dynamic subtest: test_refcounting-lmem0 [222.005156] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.060s) [222.007108] Subtest test_refcounting: SUCCESS (0.120s) [222.182300] [019/134] (815s left) gem_exec_schedule (pi-common) [222.356130] Starting subtest: pi-common [222.357548] Starting dynamic subtest: rcs0 [222.388522] Dynamic subtest rcs0: SUCCESS (0.033s) [222.399956] Starting dynamic subtest: bcs0 [222.421040] Dynamic subtest bcs0: SUCCESS (0.032s) [222.432309] Starting dynamic subtest: vcs0 [222.451000] Dynamic subtest vcs0: SUCCESS (0.030s) [222.461959] Starting dynamic subtest: vcs1 [222.481125] Dynamic subtest vcs1: SUCCESS (0.030s) [222.492160] Starting dynamic subtest: vecs0 [222.510794] Dynamic subtest vecs0: SUCCESS (0.029s) [222.512471] Subtest pi-common: SUCCESS (0.156s) [222.852107] [020/134] (815s left) perf (unprivileged-single-ctx-counters) [223.008246] Starting subtest: unprivileged-single-ctx-counters [223.011258] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [223.083372] [021/134] (815s left) api_intel_allocator (fork-simple-stress-signal) [223.128927] Starting subtest: fork-simple-stress-signal [228.560789] Subtest fork-simple-stress-signal: SUCCESS (5.430s) [228.770986] [022/134] (809s left) kms_flip (flip-vs-panning-vs-hang) [230.275061] Starting subtest: flip-vs-panning-vs-hang [230.278772] Starting dynamic subtest: A-HDMI-A4 [281.368086] Dynamic subtest A-HDMI-A4: SUCCESS (51.078s) [281.379519] Starting dynamic subtest: D-HDMI-A4 [331.332831] Dynamic subtest D-HDMI-A4: SUCCESS (49.962s) [331.334308] Subtest flip-vs-panning-vs-hang: SUCCESS (101.045s) [331.590901] [023/134] (706s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [333.086363] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [333.149386] [024/134] (705s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [333.195047] Starting subtest: invalid-multi-wait-unsubmitted-submitted [333.196621] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [333.347289] [025/134] (705s left) gem_exec_create (basic) [333.402764] Starting subtest: basic [333.404489] Starting dynamic subtest: smem [335.498211] Dynamic subtest smem: SUCCESS (2.095s) [335.511091] Starting dynamic subtest: lmem0 [337.593712] Dynamic subtest lmem0: SUCCESS (2.095s) [337.595002] Subtest basic: SUCCESS (4.191s) [337.847694] [026/134] (700s left) gem_ctx_persistence (smoketest) [337.898026] Starting subtest: smoketest [376.387728] Subtest smoketest: SUCCESS (38.477s) [376.588057] [027/134] (662s left) gem_ctx_bad_destroy (invalid-pad) [376.631278] Starting subtest: invalid-pad [376.632791] Subtest invalid-pad: SUCCESS (0.000s) [376.809600] [028/134] (662s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [378.295354] Starting subtest: cursorA-vs-flipB-legacy [378.298579] Subtest cursorA-vs-flipB-legacy: SKIP (0.002s) [378.447898] [029/134] (660s left) kms_atomic_interruptible (legacy-setmode) [379.942216] Starting subtest: legacy-setmode [379.943896] Starting dynamic subtest: pipe-A-HDMI-A-4 [386.132988] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.187s) [386.134425] Subtest legacy-setmode: SUCCESS (6.188s) [386.347894] [030/134] (652s left) kms_cdclk (mode-transition) [386.416429] Subtest mode-transition: SKIP (0.000s) [386.488159] [031/134] (652s left) kms_big_fb (linear-8bpp-rotate-270) [387.991662] Starting subtest: linear-8bpp-rotate-270 [388.098871] Subtest linear-8bpp-rotate-270: SKIP (0.106s) [388.293793] [032/134] (650s left) perf_pmu (faulting-read) [388.342729] Starting subtest: faulting-read [388.344723] Starting dynamic subtest: fixed [388.346510] Dynamic subtest fixed: SUCCESS (0.001s) [388.348378] Subtest faulting-read: SUCCESS (0.002s) [388.564501] [033/134] (650s left) kms_psr (fbc-psr2-primary-render) [390.054188] Subtest fbc-psr2-primary-render: SKIP (0.000s) [390.139601] [034/134] (649s left) gem_exec_schedule (deep) [390.355270] Starting subtest: deep [390.357394] Starting dynamic subtest: rcs0 [405.838727] Dynamic subtest rcs0: SUCCESS (15.481s) [405.853170] Starting dynamic subtest: bcs0 [421.717093] Dynamic subtest bcs0: SUCCESS (15.883s) [421.730225] Starting dynamic subtest: vcs0 [437.580870] Dynamic subtest vcs0: SUCCESS (15.863s) [437.593612] Starting dynamic subtest: vcs1 [453.960313] Dynamic subtest vcs1: SUCCESS (16.379s) [453.973358] Starting dynamic subtest: vecs0 [469.941444] Dynamic subtest vecs0: SUCCESS (15.981s) [469.942770] Subtest deep: SUCCESS (79.595s) [470.813033] [035/134] (568s left) kms_selftest (drm_plane_helper) [470.927410] Starting subtest: drm_plane_helper [470.928849] Starting dynamic subtest: drm_test_check_plane_state [471.033126] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.104s) [471.064929] Starting dynamic subtest: drm_test_check_invalid_plane_state [471.127771] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.094s) [471.130297] Subtest drm_plane_helper: SUCCESS (0.273s) [471.384784] [036/134] (568s left) syncobj_basic (bad-pad-fd-to-handle) [471.429176] Starting subtest: bad-pad-fd-to-handle [471.430669] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [471.555502] [037/134] (568s left) gem_lmem_swapping (parallel-random-engines) [475.937652] Starting subtest: parallel-random-engines [475.939249] Starting dynamic subtest: lmem0 [517.556748] Dynamic subtest lmem0: SUCCESS (41.610s) [517.558607] Subtest parallel-random-engines: SUCCESS (41.611s) [518.610980] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [518.612125] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true [518.614561] [038/134] (521s left) kms_mmap_write_crc (main) [523.379295] Starting subtest: main [523.380774] Starting dynamic subtest: pipe-A-HDMI-A-4 [527.136209] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.755s) [527.137942] Subtest main: SUCCESS (3.756s) [527.404362] [FACT kms_mmap_write_crc (main)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [527.407452] [FACT kms_mmap_write_crc (main)] new: kernel.kmod_is_loaded.i915: true [527.411641] [039/134] (512s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [528.910232] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [528.913486] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [529.147974] [040/134] (510s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [530.660070] Starting subtest: addfb25-yf-tiled-legacy [530.661721] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [530.923612] [041/134] (509s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [532.415703] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [532.418899] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [532.671079] [042/134] (507s left) gem_ctx_exec (basic) [532.731092] Starting subtest: basic [532.741056] Subtest basic: SUCCESS (0.010s) [532.955237] [043/134] (507s left) kms_atomic (test-only) [534.442944] Starting subtest: test-only [534.685906] Starting dynamic subtest: pipe-A-HDMI-A-4 [535.197011] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.511s) [535.198508] Subtest test-only: SUCCESS (0.755s) [535.397658] [044/134] (505s left) gem_set_tiling_vs_gtt [535.524908] [045/134] (505s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [537.027424] Starting subtest: yf-tiled-16bpp-rotate-0 [537.030976] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [537.282252] [046/134] (503s left) kms_getfb (getfb2-handle-zero) [538.768854] Starting subtest: getfb2-handle-zero [538.770283] Subtest getfb2-handle-zero: SUCCESS (0.000s) [539.038662] [047/134] (501s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [539.085143] Starting subtest: single-wait-all-for-submit-available-submitted [539.086656] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [539.267920] [048/134] (501s left) gem_exec_reloc (basic-wc-cpu) [539.328116] Subtest basic-wc-cpu: SKIP (0.000s) [539.426173] [049/134] (501s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [540.917434] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [540.920486] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [541.170277] [050/134] (500s left) gem_basic (multigpu-create-close) [541.216103] Starting subtest: multigpu-create-close [541.219527] Subtest multigpu-create-close: SKIP (0.000s) [541.403917] [051/134] (499s left) kms_frontbuffer_tracking (fbc-suspend) [542.899111] Starting subtest: fbc-suspend [589.144081] Subtest fbc-suspend: SUCCESS (22.498s) [592.461547] [052/134] (451s left) gem_wait (wait) [592.529563] Starting subtest: wait [592.531507] Starting dynamic subtest: all-engines [593.616731] Dynamic subtest all-engines: SUCCESS (1.056s) [593.631533] Starting dynamic subtest: rcs0 [594.663984] Dynamic subtest rcs0: SUCCESS (1.014s) [594.676935] Starting dynamic subtest: bcs0 [595.721896] Dynamic subtest bcs0: SUCCESS (1.027s) [595.769458] Starting dynamic subtest: vcs0 [596.784771] Dynamic subtest vcs0: SUCCESS (1.034s) [596.805872] Starting dynamic subtest: vcs1 [597.849873] Dynamic subtest vcs1: SUCCESS (1.039s) [597.870855] Starting dynamic subtest: vecs0 [598.914784] Dynamic subtest vecs0: SUCCESS (1.042s) [598.917600] Subtest wait: SUCCESS (6.229s) [599.211815] [053/134] (445s left) gem_exec_reloc (basic-wc-active) [599.262846] Subtest basic-wc-active: SKIP (0.000s) [599.420988] [054/134] (445s left) kms_pm_rpm (pc8-residency) [604.572748] Starting subtest: pc8-residency [604.577171] Subtest pc8-residency: SKIP (0.000s) [605.695396] [055/134] (439s left) kms_dsc (dsc-with-bpc-formats) [607.198118] Starting subtest: dsc-with-bpc-formats [607.271545] Subtest dsc-with-bpc-formats: SKIP (0.005s) [607.372098] [056/134] (437s left) kms_psr (pr-cursor-plane-move) [608.866633] Subtest pr-cursor-plane-move: SKIP (0.000s) [608.938469] [057/134] (435s left) kms_vblank (ts-continuation-dpms-suspend) [610.433780] Starting subtest: ts-continuation-dpms-suspend [610.435072] Starting dynamic subtest: pipe-A-HDMI-A-4 [631.909633] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (10.065s) [631.924622] Starting dynamic subtest: pipe-D-HDMI-A-4 [652.968518] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.575s) [652.970005] Subtest ts-continuation-dpms-suspend: SUCCESS (19.647s) [658.164311] [058/134] (391s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [658.218914] Starting subtest: multi-wait-available-unsubmitted-signaled [658.220641] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [658.374529] [059/134] (391s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [660.582974] Starting subtest: basic-flip-before-cursor-legacy [661.592341] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.982s) [661.841366] [060/134] (388s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [663.404527] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [663.518373] [061/134] (386s left) gem_exec_params (invalid-flag) [663.569103] Starting subtest: invalid-flag [663.570654] Subtest invalid-flag: SUCCESS (0.000s) [663.782854] [062/134] (386s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [665.302255] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [665.304944] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [665.550519] [063/134] (384s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [665.598605] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [665.599992] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [665.782675] [064/134] (384s left) prime_vgem (wait) [665.866257] Starting subtest: wait [665.867671] Starting dynamic subtest: rcs0 [665.922314] Dynamic subtest rcs0: SUCCESS (0.055s) [665.935288] Starting dynamic subtest: bcs0 [665.982216] Dynamic subtest bcs0: SUCCESS (0.058s) [665.999668] Starting dynamic subtest: vcs0 [666.025576] Dynamic subtest vcs0: SUCCESS (0.041s) [666.044918] Starting dynamic subtest: vcs1 [666.067583] Dynamic subtest vcs1: SUCCESS (0.040s) [666.086942] Starting dynamic subtest: vecs0 [666.109334] Dynamic subtest vecs0: SUCCESS (0.040s) [666.111032] Subtest wait: SUCCESS (0.240s) [666.326904] [065/134] (384s left) gem_exec_capture (capture) [666.379684] Starting subtest: capture [666.381376] Starting dynamic subtest: rcs0-smem [667.268994] Dynamic subtest rcs0-smem: SUCCESS (0.875s) [667.282085] Starting dynamic subtest: rcs0-lmem0 [668.136764] Dynamic subtest rcs0-lmem0: SUCCESS (0.857s) [668.149303] Starting dynamic subtest: bcs0-smem [669.512645] Dynamic subtest bcs0-smem: SUCCESS (1.360s) [669.525185] Starting dynamic subtest: bcs0-lmem0 [670.388049] Dynamic subtest bcs0-lmem0: SUCCESS (0.865s) [670.401134] Starting dynamic subtest: vcs0-smem [671.253038] Dynamic subtest vcs0-smem: SUCCESS (0.855s) [671.265495] Starting dynamic subtest: vcs0-lmem0 [672.116306] Dynamic subtest vcs0-lmem0: SUCCESS (0.857s) [672.128500] Starting dynamic subtest: vcs1-smem [673.484393] Dynamic subtest vcs1-smem: SUCCESS (1.359s) [673.496294] Starting dynamic subtest: vcs1-lmem0 [674.346262] Dynamic subtest vcs1-lmem0: SUCCESS (0.857s) [674.358039] Starting dynamic subtest: vecs0-smem [675.261722] Dynamic subtest vecs0-smem: FAIL (0.877s) [675.273449] Starting dynamic subtest: vecs0-lmem0 [676.271713] Dynamic subtest vecs0-lmem0: FAIL (0.989s) [676.273445] Subtest capture: FAIL (9.759s) [676.409755] [066/134] (374s left) kms_cursor_crc (cursor-rapid-movement-512x512) [678.162163] Starting subtest: cursor-rapid-movement-512x512 [678.164813] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [678.469759] [067/134] (372s left) kms_flip (2x-flip-vs-wf_vblank) [679.960678] Starting subtest: 2x-flip-vs-wf_vblank [679.978937] Subtest 2x-flip-vs-wf_vblank: SKIP (0.017s) [680.206827] [068/134] (370s left) i915_pm_freq_api (freq-suspend) [680.258061] Starting subtest: freq-suspend [680.259704] Starting dynamic subtest: gt0 [697.443304] Dynamic subtest gt0: SUCCESS (1.630s) [697.445455] Subtest freq-suspend: SUCCESS (1.632s) [703.724309] [069/134] (353s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [705.373320] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [705.376188] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [705.593024] [070/134] (351s left) kms_chamelium_frames (hdmi-aspect-ratio) [707.091071] Subtest hdmi-aspect-ratio: SKIP (0.000s) [707.207751] [071/134] (350s left) kms_cursor_crc (cursor-sliding-max-size) [708.978763] Starting subtest: cursor-sliding-max-size [708.986313] Subtest cursor-sliding-max-size: SKIP (0.000s) [709.237860] [072/134] (348s left) kms_color_pipeline (plane-ctm3x4-lut1d) [710.704537] Starting subtest: plane-ctm3x4-lut1d [710.740515] Starting dynamic subtest: pipe-A-HDMI-A-4 [711.152275] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.416s) [711.317536] Starting dynamic subtest: pipe-B-HDMI-A-4 [711.634520] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.332s) [711.761722] Starting dynamic subtest: pipe-C-HDMI-A-4 [712.095775] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.349s) [712.235687] Starting dynamic subtest: pipe-D-HDMI-A-4 [712.530905] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.315s) [712.597168] Subtest plane-ctm3x4-lut1d: SUCCESS (1.917s) [712.836218] [073/134] (344s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [714.315759] Starting subtest: psr-1p-pri-indfb-multidraw [714.318487] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s) [714.577172] [074/134] (343s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [716.056584] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [716.059471] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [716.272235] [075/134] (341s left) syncobj_timeline (invalid-query-illegal-handle) [716.319511] Starting subtest: invalid-query-illegal-handle [716.321019] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [716.476982] [076/134] (341s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [717.952066] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [717.953471] Starting dynamic subtest: pipe-A-HDMI-A-4 [717.967378] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [717.979744] Starting dynamic subtest: pipe-B-HDMI-A-4 [717.994012] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [718.005877] Starting dynamic subtest: pipe-C-HDMI-A-4 [718.020395] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [718.032134] Starting dynamic subtest: pipe-D-HDMI-A-4 [718.047366] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [718.050372] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.012s) [718.262716] [077/134] (339s left) kms_addfb_basic (too-high) [719.741295] Starting subtest: too-high [719.742886] Subtest too-high: SUCCESS (0.001s) [719.993595] [078/134] (338s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [721.478671] Starting subtest: psr-rgb565-draw-mmap-gtt [721.481553] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [721.727138] [079/134] (336s left) gem_mmap_offset (mmap-unmap) [721.772102] Starting subtest: mmap-unmap [721.773596] Starting dynamic subtest: lmem0 [722.977318] Dynamic subtest lmem0: SUCCESS (1.209s) [722.990383] Starting dynamic subtest: smem0 [724.775877] Dynamic subtest smem0: SUCCESS (1.803s) [724.777408] Subtest mmap-unmap: SUCCESS (3.014s) [725.059975] [080/134] (333s left) gem_pread (exhaustion) [725.106258] Subtest exhaustion: SKIP (0.000s) [725.210100] [081/134] (333s left) kms_joiner (invalid-modeset-ultra-joiner) [726.696130] Starting subtest: invalid-modeset-ultra-joiner [726.699324] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [726.913107] [082/134] (331s left) i915_drm_fdinfo (basics) [726.989530] Starting subtest: basics [726.991140] Subtest basics: SUCCESS (0.000s) [727.164764] [083/134] (331s left) gem_ccs (ctrl-surf-copy-new-ctx) [727.216181] Starting subtest: ctrl-surf-copy-new-ctx [727.219755] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [727.364136] [084/134] (331s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [728.847179] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [728.872298] Starting dynamic subtest: pipe-A-plane-0 [729.953742] Dynamic subtest pipe-A-plane-0: SUCCESS (1.083s) [729.996756] Starting dynamic subtest: pipe-A-plane-3 [730.836782] Dynamic subtest pipe-A-plane-3: SUCCESS (0.881s) [730.854811] Starting dynamic subtest: pipe-A-plane-5 [731.501684] Dynamic subtest pipe-A-plane-5: SUCCESS (0.661s) [731.543544] Starting dynamic subtest: pipe-A-plane-7 [731.546735] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [731.680676] Starting dynamic subtest: pipe-B-plane-0 [732.652950] Dynamic subtest pipe-B-plane-0: SUCCESS (0.983s) [732.699227] Starting dynamic subtest: pipe-B-plane-3 [733.434701] Dynamic subtest pipe-B-plane-3: SUCCESS (0.778s) [733.473707] Starting dynamic subtest: pipe-B-plane-5 [734.051864] Dynamic subtest pipe-B-plane-5: SUCCESS (0.613s) [734.068936] Starting dynamic subtest: pipe-B-plane-7 [734.071779] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [734.107224] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (5.267s) [734.363080] [085/134] (324s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [735.856588] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [735.859371] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [736.119515] [086/134] (322s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [737.608123] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [737.609379] Starting dynamic subtest: pipe-A-valid-mode [738.823295] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.215s) [738.825599] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.217s) [739.067227] [087/134] (319s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [740.559406] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [740.562273] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [740.801306] [088/134] (318s left) kms_draw_crc (fill-fb) [742.289501] Starting subtest: fill-fb [742.824584] Subtest fill-fb: SUCCESS (0.536s) [743.033731] [089/134] (316s left) kms_big_fb (y-tiled-8bpp-rotate-0) [744.539665] Starting subtest: y-tiled-8bpp-rotate-0 [746.191782] Subtest y-tiled-8bpp-rotate-0: SUCCESS (1.652s) [746.420810] [090/134] (312s left) gem_render_copy (yf-tiled-to-vebox-linear) [746.473905] Starting subtest: yf-tiled-to-vebox-linear [746.475242] Starting dynamic subtest: smem [746.550391] Dynamic subtest smem: SUCCESS (0.078s) [746.562689] Starting dynamic subtest: lmem0 [746.674540] Dynamic subtest lmem0: SUCCESS (0.123s) [746.675966] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.203s) [747.027725] [091/134] (312s left) syncobj_wait (invalid-reset-illegal-handle) [747.079071] Starting subtest: invalid-reset-illegal-handle [747.080651] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [747.231451] [092/134] (312s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [748.721816] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [748.724658] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [748.967108] [093/134] (310s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [750.471245] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [750.474056] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [750.723331] [094/134] (309s left) api_intel_bb (full-batch) [750.769826] Starting subtest: full-batch [750.788730] Subtest full-batch: SUCCESS (0.020s) [751.014280] [095/134] (308s left) kms_psr (fbc-psr-basic) [752.507584] Subtest fbc-psr-basic: SKIP (0.000s) [752.584341] [096/134] (307s left) gem_exercise_blt (fast-copy-emit) [752.634115] Starting subtest: fast-copy-emit [752.635429] Starting dynamic subtest: linear-smem-smem-emit [752.671226] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.036s) [752.683666] Starting dynamic subtest: linear-smem-lmem0-emit [752.687713] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s) [752.699979] Starting dynamic subtest: linear-lmem0-smem-emit [752.748268] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.059s) [752.760600] Starting dynamic subtest: linear-lmem0-lmem0-emit [752.807520] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.058s) [752.819847] Starting dynamic subtest: ymajor-smem-smem-emit [752.823762] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.015s) [752.838208] Starting dynamic subtest: ymajor-smem-lmem0-emit [752.839587] Dynamic subtest ymajor-smem-lmem0-emit: SUCCESS (0.014s) [752.851964] Starting dynamic subtest: ymajor-lmem0-smem-emit [752.900781] Dynamic subtest ymajor-lmem0-smem-emit: SUCCESS (0.060s) [752.913163] Starting dynamic subtest: ymajor-lmem0-lmem0-emit [752.960726] Dynamic subtest ymajor-lmem0-lmem0-emit: SUCCESS (0.059s) [752.973011] Starting dynamic subtest: tile4-smem-smem-emit [752.977180] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s) [752.990830] Starting dynamic subtest: tile4-smem-lmem0-emit [752.994380] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s) [753.006586] Starting dynamic subtest: tile4-lmem0-smem-emit [753.053375] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.059s) [753.065546] Starting dynamic subtest: tile4-lmem0-lmem0-emit [753.113655] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.059s) [753.125908] Starting dynamic subtest: tile64-smem-smem-emit [753.130493] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s) [753.142800] Starting dynamic subtest: tile64-smem-lmem0-emit [753.146410] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s) [753.158726] Starting dynamic subtest: tile64-lmem0-smem-emit [753.207437] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.060s) [753.219632] Starting dynamic subtest: tile64-lmem0-lmem0-emit [753.268029] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.059s) [753.269525] Subtest fast-copy-emit: SUCCESS (0.635s) [753.492379] [097/134] (306s left) sysfs_heartbeat_interval (mixed) [753.546607] Starting subtest: mixed [753.548184] Starting dynamic subtest: vecs0 [758.853980] Dynamic subtest vecs0: SUCCESS (5.306s) [758.869689] Starting dynamic subtest: vcs0 [764.141524] Dynamic subtest vcs0: SUCCESS (5.286s) [764.156831] Starting dynamic subtest: bcs0 [769.202550] Dynamic subtest bcs0: SUCCESS (5.060s) [769.222017] Starting dynamic subtest: rcs0 [774.483619] Dynamic subtest rcs0: SUCCESS (5.279s) [774.499089] Starting dynamic subtest: vcs1 [779.576800] Dynamic subtest vcs1: SUCCESS (5.092s) [779.582059] Subtest mixed: SUCCESS (26.041s) [779.797121] [098/134] (280s left) kms_cursor_legacy (cursor-vs-flip-legacy) [781.283646] Starting subtest: cursor-vs-flip-legacy [812.568126] Subtest cursor-vs-flip-legacy: SUCCESS (31.286s) [812.987688] [099/134] (247s left) gem_exec_schedule (semaphore-resolve) [813.054521] Starting subtest: semaphore-resolve [813.127770] Subtest semaphore-resolve: SUCCESS (0.073s) [813.572399] [100/134] (246s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [815.065028] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [815.068508] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [815.279578] [101/134] (245s left) kms_cursor_legacy (torture-bo) [816.767944] Starting subtest: torture-bo [816.769546] Starting dynamic subtest: pipe-A [822.285485] Dynamic subtest pipe-A: SUCCESS (5.492s) [822.317454] Starting dynamic subtest: pipe-B [827.785645] Dynamic subtest pipe-B: SUCCESS (5.483s) [827.798551] Starting dynamic subtest: pipe-C [833.243927] Dynamic subtest pipe-C: SUCCESS (5.459s) [833.256839] Starting dynamic subtest: pipe-D [838.704665] Dynamic subtest pipe-D: SUCCESS (5.459s) [838.717942] Starting dynamic subtest: all-pipes [844.173282] Dynamic subtest all-pipes: SUCCESS (5.467s) [844.175313] Subtest torture-bo: SUCCESS (27.403s) [844.391890] [102/134] (216s left) gem_ctx_shared (q-independent) [844.479958] Starting subtest: Q-independent [844.481817] Starting dynamic subtest: rcs0 [844.634216] Dynamic subtest rcs0: SUCCESS (0.150s) [844.656467] Starting dynamic subtest: bcs0 [844.724038] Dynamic subtest bcs0: SUCCESS (0.092s) [844.738939] Starting dynamic subtest: vcs0 [844.818173] Dynamic subtest vcs0: SUCCESS (0.093s) [844.831064] Starting dynamic subtest: vcs1 [844.925865] Dynamic subtest vcs1: SUCCESS (0.106s) [844.938640] Starting dynamic subtest: vecs0 [845.033571] Dynamic subtest vecs0: SUCCESS (0.106s) [845.034971] Subtest Q-independent: SUCCESS (0.555s) [845.356709] [103/134] (215s left) gem_exec_fence (syncobj-timeline-invalid-wait) [845.974020] Starting subtest: syncobj-timeline-invalid-wait [845.975606] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s) [846.305034] [104/134] (214s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [846.357325] Starting subtest: y-tiled-ccs-to-x-tiled [846.358965] Starting dynamic subtest: smem [846.447169] Dynamic subtest smem: SUCCESS (0.089s) [846.460152] Starting dynamic subtest: lmem0 [847.381343] Dynamic subtest lmem0: SUCCESS (0.929s) [847.383195] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (1.021s) [847.634921] [105/134] (213s left) drm_read (short-buffer-wakeup) [849.183351] Starting subtest: short-buffer-wakeup [881.391650] Subtest short-buffer-wakeup: SUCCESS (32.214s) [881.682129] [106/134] (179s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [883.168722] Starting subtest: plane-use-after-nonblocking-unbind-fencing [883.170245] Starting dynamic subtest: pipe-A-HDMI-A-4 [883.255581] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.087s) [883.325103] Starting dynamic subtest: pipe-B-HDMI-A-4 [883.493419] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.181s) [883.532313] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.365s) [883.714129] [107/134] (177s left) syncobj_timeline (device-submit-unordered) [883.762526] Starting subtest: device-submit-unordered [883.764040] Subtest device-submit-unordered: SUCCESS (0.000s) [883.931850] [108/134] (177s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [885.417983] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [885.419479] Starting dynamic subtest: pipe-A-HDMI-A-4 [885.459244] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s) [885.471992] Starting dynamic subtest: pipe-B-HDMI-A-4 [885.517057] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s) [885.529668] Starting dynamic subtest: pipe-C-HDMI-A-4 [885.563817] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s) [885.576050] Starting dynamic subtest: pipe-D-HDMI-A-4 [885.615747] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s) [885.618785] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.021s) [885.720550] [109/134] (175s left) kms_pipe_crc_basic (nonblocking-crc) [887.206887] Starting subtest: nonblocking-crc [887.208523] Starting dynamic subtest: pipe-A-HDMI-A-4 [887.934252] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.725s) [887.948750] Starting dynamic subtest: pipe-B-HDMI-A-4 [888.530722] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.594s) [888.546125] Starting dynamic subtest: pipe-C-HDMI-A-4 [889.130813] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.597s) [889.143793] Starting dynamic subtest: pipe-D-HDMI-A-4 [889.734757] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.603s) [889.736346] Subtest nonblocking-crc: SUCCESS (2.531s) [889.988391] [110/134] (171s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [891.480953] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [891.484219] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [891.727415] [111/134] (169s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [893.239477] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [893.242493] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [893.470104] [112/134] (168s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [894.955343] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [894.996302] Starting dynamic subtest: pipe-A-plane-0 [894.999260] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [895.012102] Starting dynamic subtest: pipe-A-plane-3 [895.015159] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [895.028199] Starting dynamic subtest: pipe-A-plane-5 [895.031280] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [895.044424] Starting dynamic subtest: pipe-A-plane-7 [895.047524] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [895.129814] Starting dynamic subtest: pipe-B-plane-0 [895.133280] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [895.146449] Starting dynamic subtest: pipe-B-plane-3 [895.149743] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [895.162694] Starting dynamic subtest: pipe-B-plane-5 [895.168480] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [895.180930] Starting dynamic subtest: pipe-B-plane-7 [895.184216] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [895.191167] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.234s) [895.413159] [113/134] (166s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [896.899532] Starting subtest: plane-downscale-factor-0-5-with-rotation [896.901183] Starting dynamic subtest: pipe-A [897.372385] Dynamic subtest pipe-A: SKIP (0.466s) [897.385047] Starting dynamic subtest: pipe-B [897.808711] Dynamic subtest pipe-B: SKIP (0.439s) [897.821159] Starting dynamic subtest: pipe-C [898.247520] Dynamic subtest pipe-C: SKIP (0.437s) [898.259984] Starting dynamic subtest: pipe-D [898.690107] Dynamic subtest pipe-D: SKIP (0.441s) [898.693049] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (1.788s) [898.912245] [114/134] (162s left) perf_pmu (busy-hang) [898.969760] Starting subtest: busy-hang [898.971524] Starting dynamic subtest: rcs0 [900.210630] Dynamic subtest rcs0: SUCCESS (1.241s) [900.224031] Starting dynamic subtest: bcs0 [901.407954] Dynamic subtest bcs0: SUCCESS (1.195s) [901.423938] Starting dynamic subtest: vcs0 [902.608857] Dynamic subtest vcs0: SUCCESS (1.198s) [902.624679] Starting dynamic subtest: vcs1 [903.811010] Dynamic subtest vcs1: SUCCESS (1.199s) [903.836666] Starting dynamic subtest: vecs0 [905.006850] Dynamic subtest vecs0: SUCCESS (1.192s) [905.010411] Subtest busy-hang: SUCCESS (6.041s) [905.163663] [115/134] (156s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [906.651298] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [906.652658] Starting dynamic subtest: pipe-A-HDMI-A-4 [906.665578] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [906.678671] Starting dynamic subtest: pipe-B-HDMI-A-4 [906.691925] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [906.704474] Starting dynamic subtest: pipe-C-HDMI-A-4 [906.718170] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [906.730938] Starting dynamic subtest: pipe-D-HDMI-A-4 [906.746094] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [906.748981] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.014s) [906.948030] [116/134] (155s left) kms_cursor_crc (cursor-offscreen-128x42) [908.623628] Starting subtest: cursor-offscreen-128x42 [908.632022] Starting dynamic subtest: pipe-A-HDMI-A-4 [911.158895] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.528s) [911.195399] Starting dynamic subtest: pipe-D-HDMI-A-4 [913.573904] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.390s) [913.575418] Subtest cursor-offscreen-128x42: SUCCESS (4.951s) [914.044378] [117/134] (148s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [915.562399] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [915.564066] Starting dynamic subtest: pipe-A [915.692140] Dynamic subtest pipe-A: SUCCESS (0.129s) [915.711228] Starting dynamic subtest: pipe-B [915.852756] Dynamic subtest pipe-B: SUCCESS (0.159s) [915.865935] Starting dynamic subtest: pipe-C [915.994117] Dynamic subtest pipe-C: SUCCESS (0.140s) [916.007270] Starting dynamic subtest: pipe-D [916.135072] Dynamic subtest pipe-D: SUCCESS (0.139s) [916.136667] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.574s) [916.362790] [118/134] (145s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [917.867065] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [918.961927] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.092s) [919.210814] [119/134] (143s left) syncobj_basic (bad-pad-handle-to-fd) [919.255731] Starting subtest: bad-pad-handle-to-fd [919.257123] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [919.408596] [120/134] (142s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [920.896299] Starting subtest: cursorA-vs-flipB-atomic-transitions [920.899639] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.002s) [921.093112] [121/134] (141s left) kms_frontbuffer_tracking (psr-2p-rte) [922.583925] Starting subtest: psr-2p-rte [922.587233] Subtest psr-2p-rte: SKIP (0.000s) [922.811845] [122/134] (139s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [924.321837] Starting subtest: psr-shrfb-scaledprimary [924.325048] Subtest psr-shrfb-scaledprimary: SKIP (0.000s) [924.585045] [123/134] (138s left) gen7_exec_parse (cmd-crossing-page) [924.638125] Subtest cmd-crossing-page: SKIP (0.000s) [924.719106] [124/134] (138s left) kms_frontbuffer_tracking (fbc-1p-rte) [926.208132] Starting subtest: fbc-1p-rte [929.717764] Subtest fbc-1p-rte: SUCCESS (3.510s) [930.027732] [125/134] (132s left) gem_mmap_wc (write) [930.074291] Subtest write: SKIP (0.000s) [930.147066] [126/134] (132s left) kms_busy (extended-modeset-hang-newfb) [931.638173] Starting subtest: extended-modeset-hang-newfb [931.640013] Starting dynamic subtest: pipe-A [947.194832] Dynamic subtest pipe-A: SUCCESS (15.552s) [947.211781] Starting dynamic subtest: pipe-D [962.699252] Dynamic subtest pipe-D: SUCCESS (15.495s) [962.700600] Subtest extended-modeset-hang-newfb: SUCCESS (31.055s) [962.962571] [127/134] (100s left) i915_pm_rpm (gem-evict-pwrite) [967.082249] Starting subtest: gem-evict-pwrite [967.087718] Subtest gem-evict-pwrite: SKIP (0.000s) [968.005031] [128/134] ( 95s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [969.489125] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [969.493070] Starting dynamic subtest: pipe-A-HDMI-A-4 [969.507606] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s) [969.521546] Starting dynamic subtest: pipe-B-HDMI-A-4 [969.535664] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s) [969.548875] Starting dynamic subtest: pipe-C-HDMI-A-4 [969.563333] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s) [969.576645] Starting dynamic subtest: pipe-D-HDMI-A-4 [969.591189] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s) [969.592827] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.013s) [969.773108] [129/134] ( 93s left) i915_suspend (basic-s2idle-without-i915) [969.818087] Starting subtest: basic-s2idle-without-i915 [990.685606] Subtest basic-s2idle-without-i915: SUCCESS (5.547s) [992.777097] [130/134] ( 72s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [994.256839] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [994.260704] Starting dynamic subtest: pipe-A-valid-mode [995.391410] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.147s) [995.392628] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.150s) [995.613361] [131/134] ( 69s left) kms_big_fb (4-tiled-addfb) [997.322657] Starting subtest: 4-tiled-addfb [997.326146] Subtest 4-tiled-addfb: SKIP (0.000s) [997.582226] [132/134] ( 67s left) kms_setmode (basic-clone-single-crtc) [997.631148] Starting subtest: basic-clone-single-crtc [997.636178] Subtest basic-clone-single-crtc: SKIP (0.000s) [997.818165] [133/134] ( 67s left) gem_exec_balancer (full-late-pulse) [997.877771] Starting subtest: full-late-pulse [1000.302338] Subtest full-late-pulse: SUCCESS (2.444s) [1000.839595] [134/134] ( 64s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [1002.324859] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [1002.328173] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [1002.552678] 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.