[66.526314] Initializing watchdogs [66.526394] /dev/watchdog0 [66.555561] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [66.569723] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [66.574717] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [66.577764] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [68.079423] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [68.081921] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [68.329905] [002/134] (958s left) gem_exec_params (secure-non-master) [68.382811] Starting subtest: secure-non-master [68.385501] Subtest secure-non-master: SKIP (0.000s) [68.572368] [003/134] (958s left) tools_test (tools_test) [68.625328] Starting subtest: tools_test [68.724636] Subtest tools_test: SUCCESS (0.109s) [68.843381] [004/134] (958s left) kms_selftest (drm_cmdline_parser) [68.886179] Starting subtest: drm_cmdline_parser [68.896996] Starting dynamic subtest: drm_test_cmdline_force_d_only [68.985190] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.087s) [69.000894] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [69.064285] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.079s) [69.097738] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [69.136086] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.069s) [69.163892] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [69.219624] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.084s) [69.252862] Starting dynamic subtest: drm_test_cmdline_force_e_only [69.298937] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.078s) [69.327037] Starting dynamic subtest: drm_test_cmdline_res [69.379711] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.078s) [69.413113] Starting dynamic subtest: drm_test_cmdline_res_vesa [69.477697] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.098s) [69.485912] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [69.566651] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.088s) [69.601271] Starting dynamic subtest: drm_test_cmdline_res_rblank [69.663867] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.093s) [69.698422] Starting dynamic subtest: drm_test_cmdline_res_bpp [69.749844] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.084s) [69.780863] Starting dynamic subtest: drm_test_cmdline_res_refresh [69.844989] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.094s) [69.875810] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [69.933258] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.089s) [69.967226] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [70.042092] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.106s) [70.071585] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [70.114630] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.072s) [70.146753] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [70.204329] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.088s) [70.212864] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [70.284183] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.080s) [70.320520] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [70.372786] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.087s) [70.407123] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [70.444406] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.070s) [70.473243] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [70.541117] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.093s) [70.576259] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [70.614168] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.075s) [70.636670] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [70.701826] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.086s) [70.732759] Starting dynamic subtest: drm_test_cmdline_name [70.915175] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.209s) [70.923150] Starting dynamic subtest: drm_test_cmdline_name_bpp [71.251789] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.338s) [71.261120] Starting dynamic subtest: drm_test_cmdline_name_option [71.923671] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.668s) [71.932127] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [72.304502] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.381s) [72.312717] Starting dynamic subtest: drm_test_cmdline_rotate_0 [72.419684] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.115s) [72.430241] Starting dynamic subtest: drm_test_cmdline_rotate_90 [72.504199] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.087s) [72.512729] Starting dynamic subtest: drm_test_cmdline_rotate_180 [72.585630] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.079s) [72.593935] Starting dynamic subtest: drm_test_cmdline_rotate_270 [72.667183] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.078s) [72.701732] Starting dynamic subtest: drm_test_cmdline_hmirror [72.757763] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.092s) [72.793969] Starting dynamic subtest: drm_test_cmdline_vmirror [72.860955] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.100s) [72.896044] Starting dynamic subtest: drm_test_cmdline_margin_options [72.948272] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.084s) [72.982171] Starting dynamic subtest: drm_test_cmdline_multiple_options [73.062210] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.113s) [73.097076] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [73.139093] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.076s) [73.172889] Starting dynamic subtest: drm_test_cmdline_extra_and_option [73.236892] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.097s) [73.271985] Starting dynamic subtest: drm_test_cmdline_freestanding_options [73.330922] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.092s) [73.366085] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [73.423391] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.089s) [73.457455] Starting dynamic subtest: drm_test_cmdline_panel_orientation [73.522125] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.097s) [73.556845] Starting dynamic subtest: drm_test_cmdline_invalid [73.654136] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.130s) [73.685153] Starting dynamic subtest: drm_test_cmdline_tv_options [73.733617] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.080s) [73.735562] Subtest drm_cmdline_parser: SUCCESS (4.847s) [73.981140] [005/134] (953s left) gem_exec_suspend (basic-s0) [74.053852] Starting subtest: basic-S0 [74.055742] Starting dynamic subtest: smem [94.148617] Dynamic subtest smem: SUCCESS (5.320s) [94.158515] Starting dynamic subtest: lmem0 [114.160010] Dynamic subtest lmem0: SUCCESS (5.177s) [114.161847] Subtest basic-S0: SUCCESS (10.497s) [120.469226] [006/134] (913s left) kms_content_protection (uevent) [122.021936] Starting subtest: uevent [122.034202] Subtest uevent: SKIP (0.006s) [122.271283] [007/134] (911s left) gem_eio (in-flight-suspend) [122.463656] Starting subtest: in-flight-suspend [165.568174] Subtest in-flight-suspend: SUCCESS (17.238s) [172.140030] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true [172.146691] [008/134] (866s left) gem_spin_batch (resubmit-all) [172.203840] Starting subtest: resubmit-all [172.205405] Starting dynamic subtest: rcs0 [172.226372] Dynamic subtest rcs0: SUCCESS (0.024s) [172.238870] Starting dynamic subtest: bcs0 [172.240619] Dynamic subtest bcs0: SUCCESS (0.003s) [172.251796] Starting dynamic subtest: vcs0 [172.253527] Dynamic subtest vcs0: SUCCESS (0.002s) [172.264497] Starting dynamic subtest: vcs1 [172.266313] Dynamic subtest vcs1: SUCCESS (0.002s) [172.277609] Starting dynamic subtest: vecs0 [172.279435] Dynamic subtest vecs0: SUCCESS (0.002s) [172.281237] Subtest resubmit-all: SUCCESS (0.035s) [172.504447] [009/134] (866s left) kms_psr (psr-cursor-plane-onoff) [173.992904] Subtest psr-cursor-plane-onoff: SKIP (0.000s) [174.063079] [010/134] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [175.555715] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [175.558762] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [175.805329] [011/134] (863s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [177.301711] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [177.304880] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [177.549939] [012/134] (861s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [179.065639] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [179.129946] [013/134] (860s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [180.699099] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [180.762292] [014/134] (858s left) kms_pm_rpm (basic-pci-d3-state) [184.518417] Starting subtest: basic-pci-d3-state [185.750823] Subtest basic-pci-d3-state: SUCCESS (1.236s) [186.705502] [015/134] (852s left) gem_ctx_exec (basic-norecovery) [186.756172] Starting subtest: basic-norecovery [187.030657] Subtest basic-norecovery: SUCCESS (0.276s) [187.256173] [016/134] (852s left) gem_pxp (protected-encrypted-src-copy-not-readible) [189.824080] Starting subtest: protected-encrypted-src-copy-not-readible [189.827476] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s) [189.960796] [017/134] (849s left) kms_flip (absolute-wf_vblank) [191.446452] Starting subtest: absolute-wf_vblank [191.453115] Starting dynamic subtest: A-HDMI-A4 [199.385866] Dynamic subtest A-HDMI-A4: SUCCESS (7.933s) [199.399853] Starting dynamic subtest: B-HDMI-A4 [207.068156] Dynamic subtest B-HDMI-A4: SUCCESS (7.681s) [207.080617] Starting dynamic subtest: C-HDMI-A4 [214.755257] Dynamic subtest C-HDMI-A4: SUCCESS (7.686s) [214.767733] Starting dynamic subtest: D-HDMI-A4 [222.442125] Dynamic subtest D-HDMI-A4: SUCCESS (7.686s) [222.444073] Subtest absolute-wf_vblank: SUCCESS (30.995s) [222.756132] [018/134] (817s left) prime_mmap (test_refcounting) [222.801699] Starting subtest: test_refcounting [222.803115] Starting dynamic subtest: test_refcounting-smem [222.863038] Dynamic subtest test_refcounting-smem: SUCCESS (0.062s) [222.874348] Starting dynamic subtest: test_refcounting-lmem0 [222.926984] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.064s) [222.928431] Subtest test_refcounting: SUCCESS (0.126s) [223.118468] [019/134] (816s left) gem_exec_schedule (pi-common) [223.332653] Starting subtest: pi-common [223.334563] Starting dynamic subtest: rcs0 [223.372424] Dynamic subtest rcs0: SUCCESS (0.041s) [223.384261] Starting dynamic subtest: bcs0 [223.403800] Dynamic subtest bcs0: SUCCESS (0.031s) [223.415145] Starting dynamic subtest: vcs0 [223.433514] Dynamic subtest vcs0: SUCCESS (0.029s) [223.444895] Starting dynamic subtest: vcs1 [223.463173] Dynamic subtest vcs1: SUCCESS (0.029s) [223.474699] Starting dynamic subtest: vecs0 [223.492640] Dynamic subtest vecs0: SUCCESS (0.029s) [223.494445] Subtest pi-common: SUCCESS (0.162s) [223.814701] [020/134] (816s left) perf (unprivileged-single-ctx-counters) [223.974756] Starting subtest: unprivileged-single-ctx-counters [223.978035] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [224.048404] [021/134] (815s left) api_intel_allocator (fork-simple-stress-signal) [224.103528] Starting subtest: fork-simple-stress-signal [229.537740] Subtest fork-simple-stress-signal: SUCCESS (5.431s) [229.826372] [022/134] (810s left) kms_flip (flip-vs-panning-vs-hang) [231.314396] Starting subtest: flip-vs-panning-vs-hang [231.317168] Starting dynamic subtest: A-HDMI-A4 [282.953311] Dynamic subtest A-HDMI-A4: SUCCESS (51.636s) [282.965348] Starting dynamic subtest: D-HDMI-A4 [332.922254] Dynamic subtest D-HDMI-A4: SUCCESS (49.967s) [332.925162] Subtest flip-vs-panning-vs-hang: SUCCESS (101.609s) [333.238873] [023/134] (707s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [334.734271] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [334.804990] [024/134] (705s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [334.850746] Starting subtest: invalid-multi-wait-unsubmitted-submitted [334.852103] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [335.033235] [025/134] (705s left) gem_exec_create (basic) [335.089216] Starting subtest: basic [335.090665] Starting dynamic subtest: smem [337.187886] Dynamic subtest smem: SUCCESS (2.098s) [337.200683] Starting dynamic subtest: lmem0 [339.295234] Dynamic subtest lmem0: SUCCESS (2.107s) [339.296772] Subtest basic: SUCCESS (4.206s) [339.545277] [026/134] (701s left) gem_ctx_persistence (smoketest) [339.597972] Starting subtest: smoketest [378.003702] Subtest smoketest: SUCCESS (38.406s) [378.251066] [027/134] (662s left) gem_ctx_bad_destroy (invalid-pad) [378.295268] Starting subtest: invalid-pad [378.296698] Subtest invalid-pad: SUCCESS (0.000s) [378.496044] [028/134] (662s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [379.981496] Starting subtest: cursorA-vs-flipB-legacy [379.984295] Subtest cursorA-vs-flipB-legacy: SKIP (0.002s) [380.184253] [029/134] (660s left) kms_atomic_interruptible (legacy-setmode) [381.670344] Starting subtest: legacy-setmode [381.671628] Starting dynamic subtest: pipe-A-HDMI-A-4 [387.876729] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.203s) [387.878299] Subtest legacy-setmode: SUCCESS (6.205s) [388.102209] [030/134] (652s left) kms_cdclk (mode-transition) [388.149839] Subtest mode-transition: SKIP (0.000s) [388.222570] [031/134] (652s left) kms_big_fb (linear-8bpp-rotate-270) [389.726526] Starting subtest: linear-8bpp-rotate-270 [389.833206] Subtest linear-8bpp-rotate-270: SKIP (0.107s) [390.083146] [032/134] (651s left) perf_pmu (faulting-read) [390.131741] Starting subtest: faulting-read [390.133252] Starting dynamic subtest: fixed [390.134727] Dynamic subtest fixed: SUCCESS (0.001s) [390.136179] Subtest faulting-read: SUCCESS (0.002s) [390.311759] [033/134] (650s left) kms_psr (fbc-psr2-primary-render) [391.800275] Subtest fbc-psr2-primary-render: SKIP (0.000s) [391.871376] [034/134] (649s left) gem_exec_schedule (deep) [392.086237] Starting subtest: deep [392.088188] Starting dynamic subtest: rcs0 [407.504427] Dynamic subtest rcs0: SUCCESS (15.417s) [407.517481] Starting dynamic subtest: bcs0 [423.227568] Dynamic subtest bcs0: SUCCESS (15.723s) [423.240257] Starting dynamic subtest: vcs0 [439.216142] Dynamic subtest vcs0: SUCCESS (15.988s) [439.229127] Starting dynamic subtest: vcs1 [455.466066] Dynamic subtest vcs1: SUCCESS (16.250s) [455.478816] Starting dynamic subtest: vecs0 [471.390018] Dynamic subtest vecs0: SUCCESS (15.923s) [471.391677] Subtest deep: SUCCESS (79.305s) [472.257035] [035/134] (569s left) kms_selftest (drm_plane_helper) [472.303132] Starting subtest: drm_plane_helper [472.388389] Starting dynamic subtest: drm_test_check_plane_state [472.448993] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.071s) [472.469231] Starting dynamic subtest: drm_test_check_invalid_plane_state [472.541290] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.088s) [472.543867] Subtest drm_plane_helper: SUCCESS (0.237s) [472.804747] [036/134] (568s left) syncobj_basic (bad-pad-fd-to-handle) [472.849177] Starting subtest: bad-pad-fd-to-handle [472.850700] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [473.029254] [037/134] (568s left) gem_lmem_swapping (parallel-random-engines) [477.520146] Starting subtest: parallel-random-engines [477.523598] Starting dynamic subtest: lmem0 [522.393331] Dynamic subtest lmem0: SUCCESS (44.870s) [522.395195] Subtest parallel-random-engines: SUCCESS (44.870s) [523.442306] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [523.443450] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true [523.446056] [038/134] (518s left) kms_mmap_write_crc (main) [528.303568] Starting subtest: main [528.305071] Starting dynamic subtest: pipe-A-HDMI-A-4 [532.072676] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.768s) [532.074171] Subtest main: SUCCESS (3.770s) [532.338540] [FACT kms_mmap_write_crc (main)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [532.341885] [FACT kms_mmap_write_crc (main)] new: kernel.kmod_is_loaded.i915: true [532.345453] [039/134] (509s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [533.839158] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [533.842331] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [534.093450] [040/134] (507s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [535.582741] Starting subtest: addfb25-yf-tiled-legacy [535.584291] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [535.768123] [041/134] (506s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [537.263387] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [537.266292] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [537.492245] [042/134] (504s left) gem_ctx_exec (basic) [537.539408] Starting subtest: basic [537.545154] Subtest basic: SUCCESS (0.006s) [537.763165] [043/134] (504s left) kms_atomic (test-only) [539.248068] Starting subtest: test-only [539.490866] Starting dynamic subtest: pipe-A-HDMI-A-4 [540.007069] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.516s) [540.008618] Subtest test-only: SUCCESS (0.759s) [540.229160] [044/134] (502s left) gem_set_tiling_vs_gtt [540.358085] [045/134] (502s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [541.861236] Starting subtest: yf-tiled-16bpp-rotate-0 [541.864537] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [542.117166] [046/134] (500s left) kms_getfb (getfb2-handle-zero) [543.603686] Starting subtest: getfb2-handle-zero [543.605395] Subtest getfb2-handle-zero: SUCCESS (0.000s) [543.871543] [047/134] (498s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [543.920630] Starting subtest: single-wait-all-for-submit-available-submitted [543.922513] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [544.110735] [048/134] (498s left) gem_exec_reloc (basic-wc-cpu) [544.167885] Subtest basic-wc-cpu: SKIP (0.000s) [544.259074] [049/134] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [545.750923] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [545.754488] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [545.993825] [050/134] (496s left) gem_basic (multigpu-create-close) [546.040140] Starting subtest: multigpu-create-close [546.043539] Subtest multigpu-create-close: SKIP (0.000s) [546.257131] [051/134] (496s left) kms_frontbuffer_tracking (fbc-suspend) [547.752620] Starting subtest: fbc-suspend [593.981077] Subtest fbc-suspend: SUCCESS (22.478s) [597.229199] [052/134] (448s left) gem_wait (wait) [597.292203] Starting subtest: wait [597.293922] Starting dynamic subtest: all-engines [598.381494] Dynamic subtest all-engines: SUCCESS (1.089s) [598.396583] Starting dynamic subtest: rcs0 [599.438059] Dynamic subtest rcs0: SUCCESS (1.055s) [599.459534] Starting dynamic subtest: bcs0 [600.494172] Dynamic subtest bcs0: SUCCESS (1.055s) [600.516314] Starting dynamic subtest: vcs0 [601.549141] Dynamic subtest vcs0: SUCCESS (1.054s) [601.571045] Starting dynamic subtest: vcs1 [602.606017] Dynamic subtest vcs1: SUCCESS (1.054s) [602.657847] Starting dynamic subtest: vecs0 [603.666265] Dynamic subtest vecs0: SUCCESS (1.057s) [603.668814] Subtest wait: SUCCESS (6.376s) [603.997730] [053/134] (442s left) gem_exec_reloc (basic-wc-active) [604.049139] Subtest basic-wc-active: SKIP (0.000s) [604.141560] [054/134] (442s left) kms_pm_rpm (pc8-residency) [608.261480] Starting subtest: pc8-residency [608.265153] Subtest pc8-residency: SKIP (0.000s) [609.276392] [055/134] (437s left) kms_dsc (dsc-with-bpc-formats) [610.799677] Starting subtest: dsc-with-bpc-formats [610.882210] Subtest dsc-with-bpc-formats: SKIP (0.005s) [611.010965] [056/134] (435s left) kms_psr (pr-cursor-plane-move) [612.498685] Subtest pr-cursor-plane-move: SKIP (0.000s) [612.581378] [057/134] (434s left) kms_vblank (ts-continuation-dpms-suspend) [614.068964] Starting subtest: ts-continuation-dpms-suspend [614.070689] Starting dynamic subtest: pipe-A-HDMI-A-4 [635.106037] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (10.068s) [635.120702] Starting dynamic subtest: pipe-D-HDMI-A-4 [657.099296] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.615s) [657.100597] Subtest ts-continuation-dpms-suspend: SUCCESS (19.690s) [663.289202] [058/134] (389s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [663.342620] Starting subtest: multi-wait-available-unsubmitted-signaled [663.344264] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [663.499904] [059/134] (389s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [665.640730] Starting subtest: basic-flip-before-cursor-legacy [666.666903] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.025s) [666.896241] [060/134] (385s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [668.435396] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [668.552814] [061/134] (384s left) gem_exec_params (invalid-flag) [668.602147] Starting subtest: invalid-flag [668.603600] Subtest invalid-flag: SUCCESS (0.000s) [668.811564] [062/134] (384s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [670.305327] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [670.308230] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [670.557711] [063/134] (382s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [670.606054] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [670.607600] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [670.797605] [064/134] (382s left) prime_vgem (wait) [670.895672] Starting subtest: wait [670.897549] Starting dynamic subtest: rcs0 [670.996644] Dynamic subtest rcs0: SUCCESS (0.103s) [671.010427] Starting dynamic subtest: bcs0 [671.054187] Dynamic subtest bcs0: SUCCESS (0.056s) [671.072063] Starting dynamic subtest: vcs0 [671.096301] Dynamic subtest vcs0: SUCCESS (0.041s) [671.115640] Starting dynamic subtest: vcs1 [671.138069] Dynamic subtest vcs1: SUCCESS (0.040s) [671.157370] Starting dynamic subtest: vecs0 [671.177397] Dynamic subtest vecs0: SUCCESS (0.038s) [671.179269] Subtest wait: SUCCESS (0.285s) [671.408428] [065/134] (381s left) gem_exec_capture (capture) [671.460361] Starting subtest: capture [671.462040] Starting dynamic subtest: rcs0-smem [672.343445] Dynamic subtest rcs0-smem: SUCCESS (0.884s) [672.356093] Starting dynamic subtest: rcs0-lmem0 [673.205698] Dynamic subtest rcs0-lmem0: SUCCESS (0.860s) [673.217828] Starting dynamic subtest: bcs0-smem [674.572912] Dynamic subtest bcs0-smem: SUCCESS (1.367s) [674.585128] Starting dynamic subtest: bcs0-lmem0 [675.437086] Dynamic subtest bcs0-lmem0: SUCCESS (0.863s) [675.449240] Starting dynamic subtest: vcs0-smem [676.295880] Dynamic subtest vcs0-smem: SUCCESS (0.858s) [676.308180] Starting dynamic subtest: vcs0-lmem0 [677.151889] Dynamic subtest vcs0-lmem0: SUCCESS (0.855s) [677.164028] Starting dynamic subtest: vcs1-smem [678.513064] Dynamic subtest vcs1-smem: SUCCESS (1.360s) [678.525471] Starting dynamic subtest: vcs1-lmem0 [679.371665] Dynamic subtest vcs1-lmem0: SUCCESS (0.855s) [679.383906] Starting dynamic subtest: vecs0-smem [680.794112] Dynamic subtest vecs0-smem: FAIL (1.386s) [680.806104] Starting dynamic subtest: vecs0-lmem0 [681.806263] Dynamic subtest vecs0-lmem0: FAIL (0.986s) [681.807934] Subtest capture: FAIL (10.283s) [681.965161] [066/134] (371s left) kms_cursor_crc (cursor-rapid-movement-512x512) [683.717672] Starting subtest: cursor-rapid-movement-512x512 [683.720825] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [684.030247] [067/134] (369s left) kms_flip (2x-flip-vs-wf_vblank) [685.517458] Starting subtest: 2x-flip-vs-wf_vblank [685.535153] Subtest 2x-flip-vs-wf_vblank: SKIP (0.017s) [685.753544] [068/134] (367s left) i915_pm_freq_api (freq-suspend) [685.806523] Starting subtest: freq-suspend [685.808284] Starting dynamic subtest: gt0 [701.933754] Dynamic subtest gt0: SUCCESS (1.589s) [701.935333] Subtest freq-suspend: SUCCESS (1.591s) [708.230538] [069/134] (351s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [710.387122] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [710.390739] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [710.603655] [070/134] (349s left) kms_chamelium_frames (hdmi-aspect-ratio) [712.150467] Subtest hdmi-aspect-ratio: SKIP (0.000s) [712.270309] [071/134] (347s left) kms_cursor_crc (cursor-sliding-max-size) [714.070885] Starting subtest: cursor-sliding-max-size [714.075541] Subtest cursor-sliding-max-size: SKIP (0.000s) [714.280539] [072/134] (345s left) kms_color_pipeline (plane-ctm3x4-lut1d) [715.772200] Starting subtest: plane-ctm3x4-lut1d [715.809086] Starting dynamic subtest: pipe-A-HDMI-A-4 [716.225413] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.416s) [716.364958] Starting dynamic subtest: pipe-B-HDMI-A-4 [716.686645] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.332s) [716.835856] Starting dynamic subtest: pipe-C-HDMI-A-4 [717.174671] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.349s) [717.314525] Starting dynamic subtest: pipe-D-HDMI-A-4 [717.654407] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.349s) [717.724552] Subtest plane-ctm3x4-lut1d: SUCCESS (1.951s) [717.968650] [073/134] (342s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [719.462674] Starting subtest: psr-1p-pri-indfb-multidraw [719.465916] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s) [719.692890] [074/134] (340s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [721.187626] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [721.191292] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [721.444132] [075/134] (339s left) syncobj_timeline (invalid-query-illegal-handle) [721.493299] Starting subtest: invalid-query-illegal-handle [721.495452] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [721.666294] [076/134] (338s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [723.153555] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [723.155199] Starting dynamic subtest: pipe-A-HDMI-A-4 [723.170685] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [723.183529] Starting dynamic subtest: pipe-B-HDMI-A-4 [723.199746] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [723.212146] Starting dynamic subtest: pipe-C-HDMI-A-4 [723.228597] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [723.241241] Starting dynamic subtest: pipe-D-HDMI-A-4 [723.269376] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [723.272135] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.013s) [723.475164] [077/134] (337s left) kms_addfb_basic (too-high) [724.961163] Starting subtest: too-high [724.962548] Subtest too-high: SUCCESS (0.001s) [725.228161] [078/134] (335s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [726.735414] Starting subtest: psr-rgb565-draw-mmap-gtt [726.738641] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [726.994594] [079/134] (333s left) gem_mmap_offset (mmap-unmap) [727.042279] Starting subtest: mmap-unmap [727.043994] Starting dynamic subtest: lmem0 [728.258309] Dynamic subtest lmem0: SUCCESS (1.203s) [728.270587] Starting dynamic subtest: smem0 [729.997198] Dynamic subtest smem0: SUCCESS (1.748s) [729.998600] Subtest mmap-unmap: SUCCESS (2.953s) [730.256524] [080/134] (330s left) gem_pread (exhaustion) [730.306297] Subtest exhaustion: SKIP (0.000s) [730.418069] [081/134] (330s left) kms_joiner (invalid-modeset-ultra-joiner) [731.909337] Starting subtest: invalid-modeset-ultra-joiner [731.912063] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [732.122918] [082/134] (329s left) i915_drm_fdinfo (basics) [732.172387] Starting subtest: basics [732.173794] Subtest basics: SUCCESS (0.000s) [732.336120] [083/134] (328s left) gem_ccs (ctrl-surf-copy-new-ctx) [732.390990] Starting subtest: ctrl-surf-copy-new-ctx [732.393891] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [732.523980] [084/134] (328s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [734.013476] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [734.040943] Starting dynamic subtest: pipe-A-plane-0 [735.107493] Dynamic subtest pipe-A-plane-0: SUCCESS (1.066s) [735.140871] Starting dynamic subtest: pipe-A-plane-3 [735.973845] Dynamic subtest pipe-A-plane-3: SUCCESS (0.864s) [735.986677] Starting dynamic subtest: pipe-A-plane-5 [736.675334] Dynamic subtest pipe-A-plane-5: SUCCESS (0.699s) [736.719049] Starting dynamic subtest: pipe-A-plane-7 [736.722288] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [736.840007] Starting dynamic subtest: pipe-B-plane-0 [737.795645] Dynamic subtest pipe-B-plane-0: SUCCESS (0.966s) [737.834967] Starting dynamic subtest: pipe-B-plane-3 [738.695949] Dynamic subtest pipe-B-plane-3: SUCCESS (0.896s) [738.740781] Starting dynamic subtest: pipe-B-plane-5 [739.395177] Dynamic subtest pipe-B-plane-5: SUCCESS (0.695s) [739.408848] Starting dynamic subtest: pipe-B-plane-7 [739.412178] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [739.452164] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (5.439s) [739.723494] [085/134] (321s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [741.218977] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [741.222112] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [741.446599] [086/134] (320s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [742.934399] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [742.936007] Starting dynamic subtest: pipe-A-valid-mode [744.095361] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.160s) [744.097386] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.163s) [744.368494] [087/134] (317s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [745.862423] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [745.865437] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [746.099357] [088/134] (315s left) kms_draw_crc (fill-fb) [747.603630] Starting subtest: fill-fb [748.137720] Subtest fill-fb: SUCCESS (0.535s) [748.343954] [089/134] (313s left) kms_big_fb (y-tiled-8bpp-rotate-0) [749.850263] Starting subtest: y-tiled-8bpp-rotate-0 [751.508657] Subtest y-tiled-8bpp-rotate-0: SUCCESS (1.655s) [751.762958] [090/134] (310s left) gem_render_copy (yf-tiled-to-vebox-linear) [751.814294] Starting subtest: yf-tiled-to-vebox-linear [751.815855] Starting dynamic subtest: smem [751.891514] Dynamic subtest smem: SUCCESS (0.076s) [751.904213] Starting dynamic subtest: lmem0 [752.021147] Dynamic subtest lmem0: SUCCESS (0.125s) [752.022966] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.204s) [752.341561] [091/134] (309s left) syncobj_wait (invalid-reset-illegal-handle) [752.391727] Starting subtest: invalid-reset-illegal-handle [752.393580] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [752.576089] [092/134] (309s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [754.072574] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [754.075852] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [754.323711] [093/134] (308s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [755.830486] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [755.836281] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [756.107586] [094/134] (306s left) api_intel_bb (full-batch) [756.153572] Starting subtest: full-batch [756.172226] Subtest full-batch: SUCCESS (0.019s) [756.411513] [095/134] (306s left) kms_psr (fbc-psr-basic) [757.901068] Subtest fbc-psr-basic: SKIP (0.000s) [757.984342] [096/134] (304s left) gem_exercise_blt (fast-copy-emit) [758.034663] Starting subtest: fast-copy-emit [758.036340] Starting dynamic subtest: linear-smem-smem-emit [758.067724] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.033s) [758.080424] Starting dynamic subtest: linear-smem-lmem0-emit [758.084498] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s) [758.097046] Starting dynamic subtest: linear-lmem0-smem-emit [758.145376] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.060s) [758.157900] Starting dynamic subtest: linear-lmem0-lmem0-emit [758.205526] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.059s) [758.218044] Starting dynamic subtest: ymajor-smem-smem-emit [758.222179] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.015s) [758.234795] Starting dynamic subtest: ymajor-smem-lmem0-emit [758.239062] Dynamic subtest ymajor-smem-lmem0-emit: SUCCESS (0.014s) [758.251279] Starting dynamic subtest: ymajor-lmem0-smem-emit [758.298070] Dynamic subtest ymajor-lmem0-smem-emit: SUCCESS (0.059s) [758.311734] Starting dynamic subtest: ymajor-lmem0-lmem0-emit [758.357632] Dynamic subtest ymajor-lmem0-lmem0-emit: SUCCESS (0.058s) [758.371782] Starting dynamic subtest: tile4-smem-smem-emit [758.375076] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s) [758.389311] Starting dynamic subtest: tile4-smem-lmem0-emit [758.391041] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s) [758.405453] Starting dynamic subtest: tile4-lmem0-smem-emit [758.452148] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.060s) [758.466423] Starting dynamic subtest: tile4-lmem0-lmem0-emit [758.513124] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.060s) [758.524954] Starting dynamic subtest: tile64-smem-smem-emit [758.532858] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s) [758.545160] Starting dynamic subtest: tile64-smem-lmem0-emit [758.546506] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s) [758.558708] Starting dynamic subtest: tile64-lmem0-smem-emit [758.607111] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.060s) [758.619137] Starting dynamic subtest: tile64-lmem0-lmem0-emit [758.666604] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.058s) [758.667952] Subtest fast-copy-emit: SUCCESS (0.634s) [758.845840] [097/134] (303s left) sysfs_heartbeat_interval (mixed) [758.904307] Starting subtest: mixed [758.905737] Starting dynamic subtest: vecs0 [764.197873] Dynamic subtest vecs0: SUCCESS (5.294s) [764.212973] Starting dynamic subtest: vcs0 [769.282980] Dynamic subtest vcs0: SUCCESS (5.083s) [769.299773] Starting dynamic subtest: bcs0 [774.345232] Dynamic subtest bcs0: SUCCESS (5.058s) [774.361952] Starting dynamic subtest: rcs0 [779.644778] Dynamic subtest rcs0: SUCCESS (5.296s) [779.660279] Starting dynamic subtest: vcs1 [784.699755] Dynamic subtest vcs1: SUCCESS (5.053s) [784.701231] Subtest mixed: SUCCESS (25.799s) [784.940397] [098/134] (278s left) kms_cursor_legacy (cursor-vs-flip-legacy) [786.427872] Starting subtest: cursor-vs-flip-legacy [817.796112] Subtest cursor-vs-flip-legacy: SUCCESS (31.367s) [818.017723] [099/134] (245s left) gem_exec_schedule (semaphore-resolve) [818.080019] Starting subtest: semaphore-resolve [818.141555] Subtest semaphore-resolve: SUCCESS (0.061s) [818.618469] [100/134] (244s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [820.114553] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [820.117907] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [820.367258] [101/134] (242s left) kms_cursor_legacy (torture-bo) [821.855009] Starting subtest: torture-bo [821.856460] Starting dynamic subtest: pipe-A [827.347767] Dynamic subtest pipe-A: SUCCESS (5.481s) [827.364347] Starting dynamic subtest: pipe-B [832.820340] Dynamic subtest pipe-B: SUCCESS (5.465s) [832.833226] Starting dynamic subtest: pipe-C [838.297948] Dynamic subtest pipe-C: SUCCESS (5.476s) [838.311282] Starting dynamic subtest: pipe-D [843.775636] Dynamic subtest pipe-D: SUCCESS (5.476s) [843.790911] Starting dynamic subtest: all-pipes [849.255299] Dynamic subtest all-pipes: SUCCESS (5.478s) [849.256955] Subtest torture-bo: SUCCESS (27.398s) [849.435903] [102/134] (213s left) gem_ctx_shared (q-independent) [849.495917] Starting subtest: Q-independent [849.497463] Starting dynamic subtest: rcs0 [849.650499] Dynamic subtest rcs0: SUCCESS (0.151s) [849.663901] Starting dynamic subtest: bcs0 [849.740644] Dynamic subtest bcs0: SUCCESS (0.092s) [849.753872] Starting dynamic subtest: vcs0 [849.836480] Dynamic subtest vcs0: SUCCESS (0.094s) [849.849252] Starting dynamic subtest: vcs1 [849.944697] Dynamic subtest vcs1: SUCCESS (0.107s) [849.957789] Starting dynamic subtest: vecs0 [850.052344] Dynamic subtest vecs0: SUCCESS (0.106s) [850.054031] Subtest Q-independent: SUCCESS (0.557s) [850.418263] [103/134] (213s left) gem_exec_fence (syncobj-timeline-invalid-wait) [851.056945] Starting subtest: syncobj-timeline-invalid-wait [851.064570] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.008s) [851.363712] [104/134] (212s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [851.416035] Starting subtest: y-tiled-ccs-to-x-tiled [851.417300] Starting dynamic subtest: smem [851.506968] Dynamic subtest smem: SUCCESS (0.090s) [851.522146] Starting dynamic subtest: lmem0 [852.445031] Dynamic subtest lmem0: SUCCESS (0.933s) [852.446622] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (1.026s) [852.770642] [105/134] (210s left) drm_read (short-buffer-wakeup) [854.314632] Starting subtest: short-buffer-wakeup [886.529494] Subtest short-buffer-wakeup: SUCCESS (32.214s) [886.797678] [106/134] (176s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [888.284679] Starting subtest: plane-use-after-nonblocking-unbind-fencing [888.286424] Starting dynamic subtest: pipe-A-HDMI-A-4 [888.378368] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.093s) [888.447017] Starting dynamic subtest: pipe-B-HDMI-A-4 [888.625873] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.190s) [888.665849] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.382s) [888.874331] [107/134] (174s left) syncobj_timeline (device-submit-unordered) [888.922345] Starting subtest: device-submit-unordered [888.923863] Subtest device-submit-unordered: SUCCESS (0.000s) [889.130394] [108/134] (174s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [890.618739] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [890.620398] Starting dynamic subtest: pipe-A-HDMI-A-4 [890.663317] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s) [890.676752] Starting dynamic subtest: pipe-B-HDMI-A-4 [890.721424] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s) [890.734344] Starting dynamic subtest: pipe-C-HDMI-A-4 [890.788698] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s) [890.801415] Starting dynamic subtest: pipe-D-HDMI-A-4 [890.849787] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s) [890.853738] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.021s) [890.931808] [109/134] (173s left) kms_pipe_crc_basic (nonblocking-crc) [892.417363] Starting subtest: nonblocking-crc [892.421192] Starting dynamic subtest: pipe-A-HDMI-A-4 [893.208705] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.787s) [893.221540] Starting dynamic subtest: pipe-B-HDMI-A-4 [893.804687] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.594s) [893.819901] Starting dynamic subtest: pipe-C-HDMI-A-4 [894.370453] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.563s) [894.386278] Starting dynamic subtest: pipe-D-HDMI-A-4 [894.978690] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.605s) [894.980443] Subtest nonblocking-crc: SUCCESS (2.561s) [895.227089] [110/134] (168s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [896.726626] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [896.729905] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [896.982979] [111/134] (167s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [898.476523] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [898.480367] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [898.725099] [112/134] (165s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [900.211071] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [900.242634] Starting dynamic subtest: pipe-A-plane-0 [900.246455] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [900.259258] Starting dynamic subtest: pipe-A-plane-3 [900.262789] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [900.275370] Starting dynamic subtest: pipe-A-plane-5 [900.279126] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [900.292187] Starting dynamic subtest: pipe-A-plane-7 [900.295894] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [900.409976] Starting dynamic subtest: pipe-B-plane-0 [900.413300] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [900.425864] Starting dynamic subtest: pipe-B-plane-3 [900.428755] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [900.441007] Starting dynamic subtest: pipe-B-plane-5 [900.444337] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [900.457156] Starting dynamic subtest: pipe-B-plane-7 [900.460269] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [900.472870] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.260s) [900.681968] [113/134] (163s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [902.169729] Starting subtest: plane-downscale-factor-0-5-with-rotation [902.171108] Starting dynamic subtest: pipe-A [902.682664] Dynamic subtest pipe-A: SKIP (0.510s) [902.695255] Starting dynamic subtest: pipe-B [903.148882] Dynamic subtest pipe-B: SKIP (0.463s) [903.161654] Starting dynamic subtest: pipe-C [903.621584] Dynamic subtest pipe-C: SKIP (0.471s) [903.634381] Starting dynamic subtest: pipe-D [904.095154] Dynamic subtest pipe-D: SKIP (0.474s) [904.098301] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (1.925s) [904.292631] [114/134] (160s left) perf_pmu (busy-hang) [904.350738] Starting subtest: busy-hang [904.352602] Starting dynamic subtest: rcs0 [905.599031] Dynamic subtest rcs0: SUCCESS (1.248s) [905.612698] Starting dynamic subtest: bcs0 [906.804185] Dynamic subtest bcs0: SUCCESS (1.203s) [906.819724] Starting dynamic subtest: vcs0 [908.001238] Dynamic subtest vcs0: SUCCESS (1.193s) [908.016708] Starting dynamic subtest: vcs1 [909.197228] Dynamic subtest vcs1: SUCCESS (1.192s) [909.212997] Starting dynamic subtest: vecs0 [910.398229] Dynamic subtest vecs0: SUCCESS (1.197s) [910.402241] Subtest busy-hang: SUCCESS (6.050s) [910.560180] [115/134] (154s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [912.048964] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [912.050310] Starting dynamic subtest: pipe-A-HDMI-A-4 [912.063610] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [912.077011] Starting dynamic subtest: pipe-B-HDMI-A-4 [912.093405] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [912.106355] Starting dynamic subtest: pipe-C-HDMI-A-4 [912.120527] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [912.133741] Starting dynamic subtest: pipe-D-HDMI-A-4 [912.149727] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [912.152784] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.014s) [912.372943] [116/134] (152s left) kms_cursor_crc (cursor-offscreen-128x42) [914.053093] Starting subtest: cursor-offscreen-128x42 [914.060867] Starting dynamic subtest: pipe-A-HDMI-A-4 [916.578564] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.515s) [916.614882] Starting dynamic subtest: pipe-D-HDMI-A-4 [919.013343] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.409s) [919.014947] Subtest cursor-offscreen-128x42: SUCCESS (4.959s) [919.424689] [117/134] (145s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [920.912813] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [920.914277] Starting dynamic subtest: pipe-A [921.041817] Dynamic subtest pipe-A: SUCCESS (0.131s) [921.063801] Starting dynamic subtest: pipe-B [921.218925] Dynamic subtest pipe-B: SUCCESS (0.175s) [921.232672] Starting dynamic subtest: pipe-C [921.360703] Dynamic subtest pipe-C: SUCCESS (0.140s) [921.374620] Starting dynamic subtest: pipe-D [921.502937] Dynamic subtest pipe-D: SUCCESS (0.141s) [921.504846] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.594s) [921.745054] [118/134] (143s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [923.249529] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [924.347402] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.094s) [924.575368] [119/134] (140s left) syncobj_basic (bad-pad-handle-to-fd) [924.622800] Starting subtest: bad-pad-handle-to-fd [924.624528] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [924.774077] [120/134] (140s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [926.260976] Starting subtest: cursorA-vs-flipB-atomic-transitions [926.263837] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.002s) [926.473086] [121/134] (138s left) kms_frontbuffer_tracking (psr-2p-rte) [927.965632] Starting subtest: psr-2p-rte [927.968363] Subtest psr-2p-rte: SKIP (0.000s) [928.193693] [122/134] (137s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [929.686622] Starting subtest: psr-shrfb-scaledprimary [929.689924] Subtest psr-shrfb-scaledprimary: SKIP (0.000s) [929.914542] [123/134] (135s left) gen7_exec_parse (cmd-crossing-page) [930.000604] Subtest cmd-crossing-page: SKIP (0.000s) [930.072831] [124/134] (135s left) kms_frontbuffer_tracking (fbc-1p-rte) [931.564687] Starting subtest: fbc-1p-rte [935.066095] Subtest fbc-1p-rte: SUCCESS (3.503s) [935.365866] [125/134] (130s left) gem_mmap_wc (write) [935.413865] Subtest write: SKIP (0.000s) [935.496943] [126/134] (130s left) kms_busy (extended-modeset-hang-newfb) [936.987725] Starting subtest: extended-modeset-hang-newfb [936.991897] Starting dynamic subtest: pipe-A [952.550894] Dynamic subtest pipe-A: SUCCESS (15.561s) [952.568003] Starting dynamic subtest: pipe-D [968.071280] Dynamic subtest pipe-D: SUCCESS (15.514s) [968.072737] Subtest extended-modeset-hang-newfb: SUCCESS (31.084s) [968.324147] [127/134] ( 97s left) i915_pm_rpm (gem-evict-pwrite) [972.152884] Starting subtest: gem-evict-pwrite [972.156147] Subtest gem-evict-pwrite: SKIP (0.000s) [973.134681] [128/134] ( 92s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [974.638150] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [974.639721] Starting dynamic subtest: pipe-A-HDMI-A-4 [974.653677] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s) [974.667354] Starting dynamic subtest: pipe-B-HDMI-A-4 [974.681710] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s) [974.695094] Starting dynamic subtest: pipe-C-HDMI-A-4 [974.709697] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s) [974.723300] Starting dynamic subtest: pipe-D-HDMI-A-4 [974.738507] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s) [974.739787] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.013s) [974.951741] [129/134] ( 91s left) i915_suspend (basic-s2idle-without-i915) [974.995894] Starting subtest: basic-s2idle-without-i915 [995.242451] Subtest basic-s2idle-without-i915: SUCCESS (5.649s) [998.422813] [130/134] ( 70s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [1000.573853] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [1000.575308] Starting dynamic subtest: pipe-A-valid-mode [1001.706106] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.126s) [1001.707902] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.128s) [1001.934103] [131/134] ( 67s left) kms_big_fb (4-tiled-addfb) [1003.444559] Starting subtest: 4-tiled-addfb [1003.448330] Subtest 4-tiled-addfb: SKIP (0.000s) [1003.653165] [132/134] ( 65s left) kms_setmode (basic-clone-single-crtc) [1003.699417] Starting subtest: basic-clone-single-crtc [1003.704954] Subtest basic-clone-single-crtc: SKIP (0.000s) [1003.898963] [133/134] ( 65s left) gem_exec_balancer (full-late-pulse) [1003.958500] Starting subtest: full-late-pulse [1006.356707] Subtest full-late-pulse: SUCCESS (2.393s) [1006.832103] [134/134] ( 62s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [1008.329248] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [1008.332431] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [1008.599756] 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.