[65.411394] Initializing watchdogs [65.411473] /dev/watchdog0 [65.440381] [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.454613] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [65.459857] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [65.462975] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [66.961946] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [66.964573] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [67.193321] [002/134] (958s left) gem_exec_params (secure-non-master) [67.246132] Starting subtest: secure-non-master [67.248949] Subtest secure-non-master: SKIP (0.000s) [67.452847] [003/134] (958s left) tools_test (tools_test) [67.506210] Starting subtest: tools_test [67.606750] Subtest tools_test: SUCCESS (0.111s) [67.738422] [004/134] (958s left) kms_selftest (drm_cmdline_parser) [67.854538] Starting subtest: drm_cmdline_parser [67.867168] Starting dynamic subtest: drm_test_cmdline_force_d_only [67.944307] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.077s) [67.957159] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [68.016696] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.071s) [68.050784] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [68.107764] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.088s) [68.141259] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [68.194723] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.085s) [68.227313] Starting dynamic subtest: drm_test_cmdline_force_e_only [68.269145] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.075s) [68.296800] Starting dynamic subtest: drm_test_cmdline_res [68.357971] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.088s) [68.393444] Starting dynamic subtest: drm_test_cmdline_res_vesa [68.444115] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.082s) [68.476863] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [68.528913] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.084s) [68.537210] Starting dynamic subtest: drm_test_cmdline_res_rblank [68.621095] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.092s) [68.655656] Starting dynamic subtest: drm_test_cmdline_res_bpp [68.707891] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.082s) [68.716484] Starting dynamic subtest: drm_test_cmdline_res_refresh [68.795239] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.086s) [68.830161] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [68.895261] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.098s) [68.922602] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [68.964624] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.071s) [68.996687] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [69.070833] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.094s) [69.105173] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [69.159489] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.097s) [69.192233] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [69.251717] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.091s) [69.288206] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [69.346074] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.091s) [69.375928] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [69.410799] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.066s) [69.437297] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [69.494117] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.083s) [69.529476] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [69.595045] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.099s) [69.630029] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [69.678902] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.083s) [69.714229] Starting dynamic subtest: drm_test_cmdline_name [69.751344] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.069s) [69.775165] Starting dynamic subtest: drm_test_cmdline_name_bpp [69.844290] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.094s) [69.879475] Starting dynamic subtest: drm_test_cmdline_name_option [69.924526] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.079s) [69.953799] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [70.012950] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.086s) [70.046557] Starting dynamic subtest: drm_test_cmdline_rotate_0 [70.086227] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.072s) [70.114838] Starting dynamic subtest: drm_test_cmdline_rotate_90 [70.171376] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.082s) [70.206049] Starting dynamic subtest: drm_test_cmdline_rotate_180 [70.262225] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.092s) [70.296628] Starting dynamic subtest: drm_test_cmdline_rotate_270 [70.351583] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.085s) [70.380773] Starting dynamic subtest: drm_test_cmdline_hmirror [70.437396] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.084s) [70.471166] Starting dynamic subtest: drm_test_cmdline_vmirror [70.525201] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.088s) [70.557768] Starting dynamic subtest: drm_test_cmdline_margin_options [70.613951] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.085s) [70.649684] Starting dynamic subtest: drm_test_cmdline_multiple_options [70.691460] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.080s) [70.722090] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [70.847182] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.151s) [70.855890] Starting dynamic subtest: drm_test_cmdline_extra_and_option [71.001607] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.154s) [71.009887] Starting dynamic subtest: drm_test_cmdline_freestanding_options [71.915985] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.914s) [71.924134] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [72.190232] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.275s) [72.198160] Starting dynamic subtest: drm_test_cmdline_panel_orientation [72.361086] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.171s) [72.372280] Starting dynamic subtest: drm_test_cmdline_invalid [72.438613] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.080s) [72.447867] Starting dynamic subtest: drm_test_cmdline_tv_options [72.534746] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.094s) [72.536049] Subtest drm_cmdline_parser: SUCCESS (4.751s) [72.771887] [005/134] (953s left) gem_exec_suspend (basic-s0) [72.827686] Starting subtest: basic-S0 [72.829165] Starting dynamic subtest: smem [93.247697] Dynamic subtest smem: SUCCESS (5.327s) [93.257154] Starting dynamic subtest: lmem0 [113.282582] Dynamic subtest lmem0: SUCCESS (5.301s) [113.284438] Subtest basic-S0: SUCCESS (10.629s) [118.610254] [006/134] (912s left) kms_content_protection (uevent) [120.157816] Starting subtest: uevent [120.170167] Subtest uevent: SKIP (0.005s) [120.409123] [007/134] (911s left) gem_eio (in-flight-suspend) [120.621505] Starting subtest: in-flight-suspend [163.659346] Subtest in-flight-suspend: SUCCESS (17.245s) [169.231218] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true [169.237435] [008/134] (866s left) gem_spin_batch (resubmit-all) [169.293749] Starting subtest: resubmit-all [169.295334] Starting dynamic subtest: rcs0 [169.315729] Dynamic subtest rcs0: SUCCESS (0.022s) [169.327920] Starting dynamic subtest: bcs0 [169.329630] Dynamic subtest bcs0: SUCCESS (0.002s) [169.340801] Starting dynamic subtest: vcs0 [169.342578] Dynamic subtest vcs0: SUCCESS (0.003s) [169.353563] Starting dynamic subtest: vcs1 [169.355439] Dynamic subtest vcs1: SUCCESS (0.002s) [169.366450] Starting dynamic subtest: vecs0 [169.368271] Dynamic subtest vecs0: SUCCESS (0.002s) [169.370008] Subtest resubmit-all: SUCCESS (0.033s) [169.699760] [009/134] (866s left) kms_psr (psr-cursor-plane-onoff) [171.189180] Subtest psr-cursor-plane-onoff: SKIP (0.000s) [171.267719] [010/134] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [172.761169] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [172.764171] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [173.008336] [011/134] (862s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [174.500474] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [174.503358] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [174.764308] [012/134] (861s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [176.260326] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [176.336047] [013/134] (859s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [177.833515] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [177.901833] [014/134] (858s left) kms_pm_rpm (basic-pci-d3-state) [181.642297] Starting subtest: basic-pci-d3-state [182.863176] Subtest basic-pci-d3-state: SUCCESS (1.224s) [183.837998] [015/134] (852s left) gem_ctx_exec (basic-norecovery) [183.884288] Starting subtest: basic-norecovery [184.161313] Subtest basic-norecovery: SUCCESS (0.277s) [184.346628] [016/134] (852s left) gem_pxp (protected-encrypted-src-copy-not-readible) [186.914154] Starting subtest: protected-encrypted-src-copy-not-readible [186.917422] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s) [187.063115] [017/134] (849s left) kms_flip (absolute-wf_vblank) [188.548975] Starting subtest: absolute-wf_vblank [188.555296] Starting dynamic subtest: A-HDMI-A4 [196.459021] Dynamic subtest A-HDMI-A4: SUCCESS (7.903s) [196.472183] Starting dynamic subtest: B-HDMI-A4 [204.140199] Dynamic subtest B-HDMI-A4: SUCCESS (7.680s) [204.152889] Starting dynamic subtest: C-HDMI-A4 [211.826516] Dynamic subtest C-HDMI-A4: SUCCESS (7.685s) [211.838438] Starting dynamic subtest: D-HDMI-A4 [219.512059] Dynamic subtest D-HDMI-A4: SUCCESS (7.684s) [219.513635] Subtest absolute-wf_vblank: SUCCESS (30.962s) [219.772399] [018/134] (816s left) prime_mmap (test_refcounting) [219.819392] Starting subtest: test_refcounting [219.821091] Starting dynamic subtest: test_refcounting-smem [219.879619] Dynamic subtest test_refcounting-smem: SUCCESS (0.062s) [219.890834] Starting dynamic subtest: test_refcounting-lmem0 [219.942589] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.063s) [219.943895] Subtest test_refcounting: SUCCESS (0.126s) [220.137008] [019/134] (816s left) gem_exec_schedule (pi-common) [220.308987] Starting subtest: pi-common [220.310368] Starting dynamic subtest: rcs0 [220.341113] Dynamic subtest rcs0: SUCCESS (0.033s) [220.353221] Starting dynamic subtest: bcs0 [220.373435] Dynamic subtest bcs0: SUCCESS (0.032s) [220.385240] Starting dynamic subtest: vcs0 [220.403236] Dynamic subtest vcs0: SUCCESS (0.029s) [220.415033] Starting dynamic subtest: vcs1 [220.432723] Dynamic subtest vcs1: SUCCESS (0.029s) [220.444834] Starting dynamic subtest: vecs0 [220.462479] Dynamic subtest vecs0: SUCCESS (0.029s) [220.463919] Subtest pi-common: SUCCESS (0.154s) [220.756816] [020/134] (816s left) perf (unprivileged-single-ctx-counters) [220.944545] Starting subtest: unprivileged-single-ctx-counters [220.947590] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [221.021001] [021/134] (815s left) api_intel_allocator (fork-simple-stress-signal) [221.067353] Starting subtest: fork-simple-stress-signal [226.500878] Subtest fork-simple-stress-signal: SUCCESS (5.433s) [226.687314] [022/134] (810s left) kms_flip (flip-vs-panning-vs-hang) [228.173646] Starting subtest: flip-vs-panning-vs-hang [228.175266] Starting dynamic subtest: A-HDMI-A4 [279.065849] Dynamic subtest A-HDMI-A4: SUCCESS (50.890s) [279.077631] Starting dynamic subtest: D-HDMI-A4 [329.030482] Dynamic subtest D-HDMI-A4: SUCCESS (49.963s) [329.032062] Subtest flip-vs-panning-vs-hang: SUCCESS (100.859s) [329.326532] [023/134] (707s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [330.825346] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [330.897508] [024/134] (706s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [330.943572] Starting subtest: invalid-multi-wait-unsubmitted-submitted [330.945236] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [331.123281] [025/134] (706s left) gem_exec_create (basic) [331.181294] Starting subtest: basic [331.182575] Starting dynamic subtest: smem [333.274665] Dynamic subtest smem: SUCCESS (2.093s) [333.287058] Starting dynamic subtest: lmem0 [335.378182] Dynamic subtest lmem0: SUCCESS (2.103s) [335.379622] Subtest basic: SUCCESS (4.197s) [335.668935] [026/134] (701s left) gem_ctx_persistence (smoketest) [335.720586] Starting subtest: smoketest [374.212917] Subtest smoketest: SUCCESS (38.491s) [374.407512] [027/134] (663s left) gem_ctx_bad_destroy (invalid-pad) [374.457244] Starting subtest: invalid-pad [374.459106] Subtest invalid-pad: SUCCESS (0.000s) [374.657655] [028/134] (662s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [376.144164] Starting subtest: cursorA-vs-flipB-legacy [376.147226] Subtest cursorA-vs-flipB-legacy: SKIP (0.002s) [376.341313] [029/134] (661s left) kms_atomic_interruptible (legacy-setmode) [377.828177] Starting subtest: legacy-setmode [377.829754] Starting dynamic subtest: pipe-A-HDMI-A-4 [384.033914] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.205s) [384.035288] Subtest legacy-setmode: SUCCESS (6.206s) [384.244084] [030/134] (653s left) kms_cdclk (mode-transition) [384.291600] Subtest mode-transition: SKIP (0.000s) [384.358678] [031/134] (653s left) kms_big_fb (linear-8bpp-rotate-270) [385.858878] Starting subtest: linear-8bpp-rotate-270 [385.956130] Subtest linear-8bpp-rotate-270: SKIP (0.095s) [386.153883] [032/134] (651s left) perf_pmu (faulting-read) [386.204803] Starting subtest: faulting-read [386.206683] Starting dynamic subtest: fixed [386.208517] Dynamic subtest fixed: SUCCESS (0.001s) [386.210566] Subtest faulting-read: SUCCESS (0.002s) [386.378109] [033/134] (651s left) kms_psr (fbc-psr2-primary-render) [387.863885] Subtest fbc-psr2-primary-render: SKIP (0.000s) [387.944741] [034/134] (650s left) gem_exec_schedule (deep) [388.157004] Starting subtest: deep [388.159296] Starting dynamic subtest: rcs0 [403.723045] Dynamic subtest rcs0: SUCCESS (15.564s) [403.737023] Starting dynamic subtest: bcs0 [419.958372] Dynamic subtest bcs0: SUCCESS (16.235s) [419.974334] Starting dynamic subtest: vcs0 [435.855166] Dynamic subtest vcs0: SUCCESS (15.897s) [435.868394] Starting dynamic subtest: vcs1 [451.798052] Dynamic subtest vcs1: SUCCESS (15.943s) [451.811378] Starting dynamic subtest: vecs0 [467.716030] Dynamic subtest vecs0: SUCCESS (15.918s) [467.717733] Subtest deep: SUCCESS (79.561s) [468.590055] [035/134] (569s left) kms_selftest (drm_plane_helper) [468.635249] Starting subtest: drm_plane_helper [468.711571] Starting dynamic subtest: drm_test_check_plane_state [468.803341] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.091s) [468.826011] Starting dynamic subtest: drm_test_check_invalid_plane_state [468.897071] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.090s) [468.899504] Subtest drm_plane_helper: SUCCESS (0.262s) [469.146059] [036/134] (569s left) syncobj_basic (bad-pad-fd-to-handle) [469.190301] Starting subtest: bad-pad-fd-to-handle [469.191830] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [469.368424] [037/134] (569s left) gem_lmem_swapping (parallel-random-engines) [473.700856] Starting subtest: parallel-random-engines [473.702592] Starting dynamic subtest: lmem0 [519.125495] Dynamic subtest lmem0: SUCCESS (45.421s) [519.127730] Subtest parallel-random-engines: SUCCESS (45.422s) [520.154833] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [520.156025] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true [520.158839] [038/134] (518s left) kms_mmap_write_crc (main) [524.893531] Starting subtest: main [524.894933] Starting dynamic subtest: pipe-A-HDMI-A-4 [528.612406] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.717s) [528.614027] Subtest main: SUCCESS (3.719s) [528.849458] [FACT kms_mmap_write_crc (main)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [528.852546] [FACT kms_mmap_write_crc (main)] new: kernel.kmod_is_loaded.i915: true [528.856351] [039/134] (509s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [530.354195] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [530.357279] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [530.616884] [040/134] (508s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [532.101336] Starting subtest: addfb25-yf-tiled-legacy [532.102790] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [532.358918] [041/134] (506s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [533.852027] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [533.854857] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [534.116643] [042/134] (504s left) gem_ctx_exec (basic) [534.167445] Starting subtest: basic [534.173134] Subtest basic: SUCCESS (0.006s) [534.397156] [043/134] (504s left) kms_atomic (test-only) [535.884115] Starting subtest: test-only [536.127119] Starting dynamic subtest: pipe-A-HDMI-A-4 [536.644776] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.518s) [536.646308] Subtest test-only: SUCCESS (0.762s) [536.850700] [044/134] (502s left) gem_set_tiling_vs_gtt [536.978216] [045/134] (502s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [538.481241] Starting subtest: yf-tiled-16bpp-rotate-0 [538.484686] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [538.707936] [046/134] (500s left) kms_getfb (getfb2-handle-zero) [540.192415] Starting subtest: getfb2-handle-zero [540.194112] Subtest getfb2-handle-zero: SUCCESS (0.000s) [540.426215] [047/134] (499s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [540.472120] Starting subtest: single-wait-all-for-submit-available-submitted [540.473635] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [540.671868] [048/134] (498s left) gem_exec_reloc (basic-wc-cpu) [540.726850] Subtest basic-wc-cpu: SKIP (0.000s) [540.828992] [049/134] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [542.319292] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [542.322158] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [542.573020] [050/134] (497s left) gem_basic (multigpu-create-close) [542.617733] Starting subtest: multigpu-create-close [542.620972] Subtest multigpu-create-close: SKIP (0.000s) [542.784429] [051/134] (497s left) kms_frontbuffer_tracking (fbc-suspend) [544.276132] Starting subtest: fbc-suspend [590.079912] Subtest fbc-suspend: SUCCESS (22.531s) [593.391007] [052/134] (449s left) gem_wait (wait) [593.452852] Starting subtest: wait [593.454507] Starting dynamic subtest: all-engines [594.543229] Dynamic subtest all-engines: SUCCESS (1.090s) [594.557591] Starting dynamic subtest: rcs0 [595.600801] Dynamic subtest rcs0: SUCCESS (1.055s) [595.617852] Starting dynamic subtest: bcs0 [596.659231] Dynamic subtest bcs0: SUCCESS (1.055s) [596.673738] Starting dynamic subtest: vcs0 [597.716830] Dynamic subtest vcs0: SUCCESS (1.055s) [597.737592] Starting dynamic subtest: vcs1 [598.779868] Dynamic subtest vcs1: SUCCESS (1.059s) [598.826403] Starting dynamic subtest: vecs0 [599.846828] Dynamic subtest vecs0: SUCCESS (1.063s) [599.849558] Subtest wait: SUCCESS (6.395s) [600.198445] [053/134] (442s left) gem_exec_reloc (basic-wc-active) [600.251952] Subtest basic-wc-active: SKIP (0.000s) [600.362878] [054/134] (442s left) kms_pm_rpm (pc8-residency) [603.995327] Starting subtest: pc8-residency [604.001386] Subtest pc8-residency: SKIP (0.000s) [604.962568] [055/134] (438s left) kms_dsc (dsc-with-bpc-formats) [606.477166] Starting subtest: dsc-with-bpc-formats [606.575644] Subtest dsc-with-bpc-formats: SKIP (0.005s) [606.696618] [056/134] (436s left) kms_psr (pr-cursor-plane-move) [608.185544] Subtest pr-cursor-plane-move: SKIP (0.000s) [608.259422] [057/134] (435s left) kms_vblank (ts-continuation-dpms-suspend) [609.743310] Starting subtest: ts-continuation-dpms-suspend [609.744841] Starting dynamic subtest: pipe-A-HDMI-A-4 [631.231310] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (10.021s) [631.250127] Starting dynamic subtest: pipe-D-HDMI-A-4 [653.272031] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.580s) [653.273238] Subtest ts-continuation-dpms-suspend: SUCCESS (19.608s) [660.491599] [058/134] (390s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [660.540482] Starting subtest: multi-wait-available-unsubmitted-signaled [660.541910] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [660.748067] [059/134] (389s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [662.232837] Starting subtest: basic-flip-before-cursor-legacy [663.230850] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.998s) [663.476822] [060/134] (387s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [665.015975] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [665.134144] [061/134] (385s left) gem_exec_params (invalid-flag) [665.183386] Starting subtest: invalid-flag [665.184956] Subtest invalid-flag: SUCCESS (0.000s) [665.395444] [062/134] (385s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [666.885146] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [666.888228] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [667.092904] [063/134] (383s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [667.139227] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [667.140940] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [667.340658] [064/134] (383s left) prime_vgem (wait) [667.412499] Starting subtest: wait [667.414301] Starting dynamic subtest: rcs0 [667.469936] Dynamic subtest rcs0: SUCCESS (0.057s) [667.482531] Starting dynamic subtest: bcs0 [667.526953] Dynamic subtest bcs0: SUCCESS (0.056s) [667.542405] Starting dynamic subtest: vcs0 [667.567910] Dynamic subtest vcs0: SUCCESS (0.040s) [667.586724] Starting dynamic subtest: vcs1 [667.609298] Dynamic subtest vcs1: SUCCESS (0.040s) [667.628080] Starting dynamic subtest: vecs0 [667.651030] Dynamic subtest vecs0: SUCCESS (0.040s) [667.652516] Subtest wait: SUCCESS (0.240s) [667.863358] [065/134] (383s left) gem_exec_capture (capture) [667.912450] Starting subtest: capture [667.913864] Starting dynamic subtest: rcs0-smem [668.797715] Dynamic subtest rcs0-smem: SUCCESS (0.884s) [668.810250] Starting dynamic subtest: rcs0-lmem0 [669.660729] Dynamic subtest rcs0-lmem0: SUCCESS (0.861s) [669.673045] Starting dynamic subtest: bcs0-smem [671.027807] Dynamic subtest bcs0-smem: SUCCESS (1.366s) [671.039934] Starting dynamic subtest: bcs0-lmem0 [672.011407] Dynamic subtest bcs0-lmem0: SUCCESS (0.983s) [672.023479] Starting dynamic subtest: vcs0-smem [672.872323] Dynamic subtest vcs0-smem: SUCCESS (0.859s) [672.884465] Starting dynamic subtest: vcs0-lmem0 [673.736320] Dynamic subtest vcs0-lmem0: SUCCESS (0.861s) [673.748459] Starting dynamic subtest: vcs1-smem [674.592541] Dynamic subtest vcs1-smem: SUCCESS (0.854s) [674.604570] Starting dynamic subtest: vcs1-lmem0 [675.445988] Dynamic subtest vcs1-lmem0: SUCCESS (0.856s) [675.458180] Starting dynamic subtest: vecs0-smem [676.885172] Dynamic subtest vecs0-smem: FAIL (1.388s) [676.896746] Starting dynamic subtest: vecs0-lmem0 [677.868100] Dynamic subtest vecs0-lmem0: FAIL (0.984s) [677.869797] Subtest capture: FAIL (9.907s) [678.019741] [066/134] (373s left) kms_cursor_crc (cursor-rapid-movement-512x512) [679.769401] Starting subtest: cursor-rapid-movement-512x512 [679.772727] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [680.074909] [067/134] (371s left) kms_flip (2x-flip-vs-wf_vblank) [681.564358] Starting subtest: 2x-flip-vs-wf_vblank [681.581579] Subtest 2x-flip-vs-wf_vblank: SKIP (0.017s) [681.792595] [068/134] (369s left) i915_pm_freq_api (freq-suspend) [681.844802] Starting subtest: freq-suspend [681.846577] Starting dynamic subtest: gt0 [698.173152] Dynamic subtest gt0: SUCCESS (1.664s) [698.176747] Subtest freq-suspend: SUCCESS (1.665s) [705.483577] [069/134] (353s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [706.978970] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [706.984402] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [707.248133] [070/134] (351s left) kms_chamelium_frames (hdmi-aspect-ratio) [708.786067] Subtest hdmi-aspect-ratio: SKIP (0.000s) [708.905291] [071/134] (349s left) kms_cursor_crc (cursor-sliding-max-size) [710.706282] Starting subtest: cursor-sliding-max-size [710.710808] Subtest cursor-sliding-max-size: SKIP (0.000s) [710.961318] [072/134] (348s left) kms_color_pipeline (plane-ctm3x4-lut1d) [712.478540] Starting subtest: plane-ctm3x4-lut1d [712.506481] Starting dynamic subtest: pipe-A-HDMI-A-4 [712.922858] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.416s) [713.058019] Starting dynamic subtest: pipe-B-HDMI-A-4 [713.396210] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.349s) [713.525762] Starting dynamic subtest: pipe-C-HDMI-A-4 [713.880503] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.365s) [714.008395] Starting dynamic subtest: pipe-D-HDMI-A-4 [714.350102] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.349s) [714.418654] Subtest plane-ctm3x4-lut1d: SUCCESS (1.941s) [714.631095] [073/134] (344s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [716.126289] Starting subtest: psr-1p-pri-indfb-multidraw [716.129339] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s) [716.381011] [074/134] (342s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [717.874027] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [717.877236] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [718.127330] [075/134] (341s left) syncobj_timeline (invalid-query-illegal-handle) [718.176884] Starting subtest: invalid-query-illegal-handle [718.178758] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [718.379549] [076/134] (341s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [719.868233] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [719.869802] Starting dynamic subtest: pipe-A-HDMI-A-4 [719.884900] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [719.897658] Starting dynamic subtest: pipe-B-HDMI-A-4 [719.913373] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [719.925521] Starting dynamic subtest: pipe-C-HDMI-A-4 [719.941627] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [719.953938] Starting dynamic subtest: pipe-D-HDMI-A-4 [719.971245] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [719.974582] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.012s) [720.172487] [077/134] (339s left) kms_addfb_basic (too-high) [721.658384] Starting subtest: too-high [721.660476] Subtest too-high: SUCCESS (0.001s) [721.897570] [078/134] (337s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [723.388269] Starting subtest: psr-rgb565-draw-mmap-gtt [723.391378] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [723.632960] [079/134] (336s left) gem_mmap_offset (mmap-unmap) [723.678701] Starting subtest: mmap-unmap [723.680552] Starting dynamic subtest: lmem0 [724.891387] Dynamic subtest lmem0: SUCCESS (1.213s) [724.904268] Starting dynamic subtest: smem0 [726.634883] Dynamic subtest smem0: SUCCESS (1.742s) [726.636572] Subtest mmap-unmap: SUCCESS (2.958s) [726.928358] [080/134] (332s left) gem_pread (exhaustion) [726.973680] Subtest exhaustion: SKIP (0.000s) [727.066246] [081/134] (332s left) kms_joiner (invalid-modeset-ultra-joiner) [728.557972] Starting subtest: invalid-modeset-ultra-joiner [728.561382] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [728.743115] [082/134] (331s left) i915_drm_fdinfo (basics) [728.794059] Starting subtest: basics [728.796066] Subtest basics: SUCCESS (0.000s) [728.947447] [083/134] (331s left) gem_ccs (ctrl-surf-copy-new-ctx) [728.998748] Starting subtest: ctrl-surf-copy-new-ctx [729.001407] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [729.160828] [084/134] (331s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [730.644978] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [730.674305] Starting dynamic subtest: pipe-A-plane-0 [731.758222] Dynamic subtest pipe-A-plane-0: SUCCESS (1.083s) [731.775586] Starting dynamic subtest: pipe-A-plane-3 [732.574029] Dynamic subtest pipe-A-plane-3: SUCCESS (0.812s) [732.619329] Starting dynamic subtest: pipe-A-plane-5 [733.274080] Dynamic subtest pipe-A-plane-5: SUCCESS (0.697s) [733.290493] Starting dynamic subtest: pipe-A-plane-7 [733.293320] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [733.421774] Starting dynamic subtest: pipe-B-plane-0 [734.377085] Dynamic subtest pipe-B-plane-0: SUCCESS (0.966s) [734.389865] Starting dynamic subtest: pipe-B-plane-3 [735.227750] Dynamic subtest pipe-B-plane-3: SUCCESS (0.849s) [735.278741] Starting dynamic subtest: pipe-B-plane-5 [735.912370] Dynamic subtest pipe-B-plane-5: SUCCESS (0.680s) [735.957242] Starting dynamic subtest: pipe-B-plane-7 [735.960138] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [735.982874] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (5.338s) [736.280915] [085/134] (324s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [737.781388] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [737.784525] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [738.036269] [086/134] (322s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [739.522761] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [739.524018] Starting dynamic subtest: pipe-A-valid-mode [740.740065] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.216s) [740.741482] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.218s) [740.957937] [087/134] (319s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [742.449101] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [742.451853] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [742.711326] [088/134] (318s left) kms_draw_crc (fill-fb) [744.200262] Starting subtest: fill-fb [744.738178] Subtest fill-fb: SUCCESS (0.540s) [744.958052] [089/134] (315s left) kms_big_fb (y-tiled-8bpp-rotate-0) [746.464081] Starting subtest: y-tiled-8bpp-rotate-0 [748.122922] Subtest y-tiled-8bpp-rotate-0: SUCCESS (1.659s) [748.326210] [090/134] (312s left) gem_render_copy (yf-tiled-to-vebox-linear) [748.378966] Starting subtest: yf-tiled-to-vebox-linear [748.380406] Starting dynamic subtest: smem [748.456643] Dynamic subtest smem: SUCCESS (0.077s) [748.469058] Starting dynamic subtest: lmem0 [748.582651] Dynamic subtest lmem0: SUCCESS (0.124s) [748.584149] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.204s) [748.903795] [091/134] (312s left) syncobj_wait (invalid-reset-illegal-handle) [748.948649] Starting subtest: invalid-reset-illegal-handle [748.950363] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [749.094075] [092/134] (312s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [750.586089] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [750.589117] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [750.843647] [093/134] (310s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [752.347215] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [752.350171] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [752.608771] [094/134] (308s left) api_intel_bb (full-batch) [752.656893] Starting subtest: full-batch [752.672151] Subtest full-batch: SUCCESS (0.017s) [752.910283] [095/134] (308s left) kms_psr (fbc-psr-basic) [754.398441] Subtest fbc-psr-basic: SKIP (0.000s) [754.484134] [096/134] (307s left) gem_exercise_blt (fast-copy-emit) [754.534065] Starting subtest: fast-copy-emit [754.535634] Starting dynamic subtest: linear-smem-smem-emit [754.570042] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.035s) [754.582446] Starting dynamic subtest: linear-smem-lmem0-emit [754.586587] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s) [754.599089] Starting dynamic subtest: linear-lmem0-smem-emit [754.647486] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.059s) [754.659956] Starting dynamic subtest: linear-lmem0-lmem0-emit [754.707344] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.058s) [754.719798] Starting dynamic subtest: ymajor-smem-smem-emit [754.723976] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.015s) [754.736445] Starting dynamic subtest: ymajor-smem-lmem0-emit [754.740256] Dynamic subtest ymajor-smem-lmem0-emit: SUCCESS (0.014s) [754.752705] Starting dynamic subtest: ymajor-lmem0-smem-emit [754.800827] Dynamic subtest ymajor-lmem0-smem-emit: SUCCESS (0.060s) [754.813228] Starting dynamic subtest: ymajor-lmem0-lmem0-emit [754.860830] Dynamic subtest ymajor-lmem0-lmem0-emit: SUCCESS (0.059s) [754.873315] Starting dynamic subtest: tile4-smem-smem-emit [754.877313] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s) [754.889860] Starting dynamic subtest: tile4-smem-lmem0-emit [754.893775] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.015s) [754.906324] Starting dynamic subtest: tile4-lmem0-smem-emit [754.953953] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.059s) [754.966435] Starting dynamic subtest: tile4-lmem0-lmem0-emit [755.014701] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.059s) [755.026777] Starting dynamic subtest: tile64-smem-smem-emit [755.031685] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s) [755.044272] Starting dynamic subtest: tile64-smem-lmem0-emit [755.048368] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s) [755.060910] Starting dynamic subtest: tile64-lmem0-smem-emit [755.108151] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.059s) [755.120565] Starting dynamic subtest: tile64-lmem0-lmem0-emit [755.170953] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.059s) [755.172749] Subtest fast-copy-emit: SUCCESS (0.635s) [755.411649] [097/134] (306s left) sysfs_heartbeat_interval (mixed) [755.463502] Starting subtest: mixed [755.465205] Starting dynamic subtest: vecs0 [760.539406] Dynamic subtest vecs0: SUCCESS (5.075s) [760.557474] Starting dynamic subtest: vcs0 [765.855562] Dynamic subtest vcs0: SUCCESS (5.313s) [765.871699] Starting dynamic subtest: bcs0 [770.932077] Dynamic subtest bcs0: SUCCESS (5.074s) [770.946618] Starting dynamic subtest: rcs0 [776.246545] Dynamic subtest rcs0: SUCCESS (5.312s) [776.270840] Starting dynamic subtest: vcs1 [781.322035] Dynamic subtest vcs1: SUCCESS (5.068s) [781.323380] Subtest mixed: SUCCESS (25.860s) [781.507768] [098/134] (280s left) kms_cursor_legacy (cursor-vs-flip-legacy) [782.992362] Starting subtest: cursor-vs-flip-legacy [814.344891] Subtest cursor-vs-flip-legacy: SUCCESS (31.352s) [814.561035] [099/134] (247s left) gem_exec_schedule (semaphore-resolve) [814.621332] Starting subtest: semaphore-resolve [814.684907] Subtest semaphore-resolve: SUCCESS (0.064s) [815.057313] [100/134] (246s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [816.547249] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [816.550572] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [816.810340] [101/134] (245s left) kms_cursor_legacy (torture-bo) [818.297780] Starting subtest: torture-bo [818.299311] Starting dynamic subtest: pipe-A [823.803922] Dynamic subtest pipe-A: SUCCESS (5.502s) [823.816823] Starting dynamic subtest: pipe-B [829.377306] Dynamic subtest pipe-B: SUCCESS (5.571s) [829.391052] Starting dynamic subtest: pipe-C [834.848063] Dynamic subtest pipe-C: SUCCESS (5.469s) [834.861394] Starting dynamic subtest: pipe-D [840.321473] Dynamic subtest pipe-D: SUCCESS (5.471s) [840.335216] Starting dynamic subtest: all-pipes [845.791721] Dynamic subtest all-pipes: SUCCESS (5.469s) [845.794054] Subtest torture-bo: SUCCESS (27.493s) [846.014728] [102/134] (216s left) gem_ctx_shared (q-independent) [846.073117] Starting subtest: Q-independent [846.084466] Starting dynamic subtest: rcs0 [846.225969] Dynamic subtest rcs0: SUCCESS (0.149s) [846.238862] Starting dynamic subtest: bcs0 [846.316063] Dynamic subtest bcs0: SUCCESS (0.092s) [846.335453] Starting dynamic subtest: vcs0 [846.409266] Dynamic subtest vcs0: SUCCESS (0.092s) [846.422326] Starting dynamic subtest: vcs1 [846.513931] Dynamic subtest vcs1: SUCCESS (0.103s) [846.526915] Starting dynamic subtest: vecs0 [846.619809] Dynamic subtest vecs0: SUCCESS (0.104s) [846.621341] Subtest Q-independent: SUCCESS (0.548s) [846.938527] [103/134] (215s left) gem_exec_fence (syncobj-timeline-invalid-wait) [847.560404] Starting subtest: syncobj-timeline-invalid-wait [847.562053] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.006s) [847.903255] [104/134] (214s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [847.961756] Starting subtest: y-tiled-ccs-to-x-tiled [847.963300] Starting dynamic subtest: smem [848.051977] Dynamic subtest smem: SUCCESS (0.090s) [848.065072] Starting dynamic subtest: lmem0 [848.979966] Dynamic subtest lmem0: SUCCESS (0.923s) [848.981880] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (1.016s) [849.273482] [105/134] (213s left) drm_read (short-buffer-wakeup) [850.820649] Starting subtest: short-buffer-wakeup [883.037043] Subtest short-buffer-wakeup: SUCCESS (32.214s) [883.314075] [106/134] (179s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [884.801623] Starting subtest: plane-use-after-nonblocking-unbind-fencing [884.803162] Starting dynamic subtest: pipe-A-HDMI-A-4 [884.886072] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.085s) [884.956228] Starting dynamic subtest: pipe-B-HDMI-A-4 [885.124263] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.180s) [885.163890] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.364s) [885.372190] [107/134] (177s left) syncobj_timeline (device-submit-unordered) [885.420972] Starting subtest: device-submit-unordered [885.422482] Subtest device-submit-unordered: SUCCESS (0.000s) [885.605671] [108/134] (177s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [887.101551] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [887.103061] Starting dynamic subtest: pipe-A-HDMI-A-4 [887.144842] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s) [887.157995] Starting dynamic subtest: pipe-B-HDMI-A-4 [887.199420] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s) [887.212599] Starting dynamic subtest: pipe-C-HDMI-A-4 [887.250237] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s) [887.262819] Starting dynamic subtest: pipe-D-HDMI-A-4 [887.301095] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s) [887.304321] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.021s) [887.405570] [109/134] (175s left) kms_pipe_crc_basic (nonblocking-crc) [888.893299] Starting subtest: nonblocking-crc [888.894760] Starting dynamic subtest: pipe-A-HDMI-A-4 [889.642951] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.750s) [889.658287] Starting dynamic subtest: pipe-B-HDMI-A-4 [890.238884] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.592s) [890.254556] Starting dynamic subtest: pipe-C-HDMI-A-4 [890.801295] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.561s) [890.816230] Starting dynamic subtest: pipe-D-HDMI-A-4 [891.372854] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.568s) [891.374324] Subtest nonblocking-crc: SUCCESS (2.482s) [891.590710] [110/134] (171s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [893.089365] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [893.092419] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [893.323850] [111/134] (169s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [894.817008] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [894.819998] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [895.071497] [112/134] (168s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [896.592289] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [896.617646] Starting dynamic subtest: pipe-A-plane-0 [896.620975] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [896.633671] Starting dynamic subtest: pipe-A-plane-3 [896.636975] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [896.649905] Starting dynamic subtest: pipe-A-plane-5 [896.653179] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [896.666104] Starting dynamic subtest: pipe-A-plane-7 [896.669482] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [896.750333] Starting dynamic subtest: pipe-B-plane-0 [896.754106] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [896.767021] Starting dynamic subtest: pipe-B-plane-3 [896.770669] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [896.783534] Starting dynamic subtest: pipe-B-plane-5 [896.787039] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [896.800010] Starting dynamic subtest: pipe-B-plane-7 [896.803442] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [896.807225] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.202s) [897.035052] [113/134] (166s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [898.520274] Starting subtest: plane-downscale-factor-0-5-with-rotation [898.524109] Starting dynamic subtest: pipe-A [899.026644] Dynamic subtest pipe-A: SKIP (0.501s) [899.039317] Starting dynamic subtest: pipe-B [899.454403] Dynamic subtest pipe-B: SKIP (0.429s) [899.467115] Starting dynamic subtest: pipe-C [899.894299] Dynamic subtest pipe-C: SKIP (0.438s) [899.906968] Starting dynamic subtest: pipe-D [900.335997] Dynamic subtest pipe-D: SKIP (0.438s) [900.338939] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (1.811s) [900.539696] [114/134] (162s left) perf_pmu (busy-hang) [900.596293] Starting subtest: busy-hang [900.598023] Starting dynamic subtest: rcs0 [901.832335] Dynamic subtest rcs0: SUCCESS (1.235s) [901.845933] Starting dynamic subtest: bcs0 [903.025721] Dynamic subtest bcs0: SUCCESS (1.191s) [903.041529] Starting dynamic subtest: vcs0 [904.226687] Dynamic subtest vcs0: SUCCESS (1.197s) [904.242862] Starting dynamic subtest: vcs1 [905.421748] Dynamic subtest vcs1: SUCCESS (1.191s) [905.437977] Starting dynamic subtest: vecs0 [906.618730] Dynamic subtest vecs0: SUCCESS (1.193s) [906.622897] Subtest busy-hang: SUCCESS (6.024s) [906.774553] [115/134] (156s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [908.259347] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [908.261048] Starting dynamic subtest: pipe-A-HDMI-A-4 [908.275042] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [908.288260] Starting dynamic subtest: pipe-B-HDMI-A-4 [908.301270] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [908.314500] Starting dynamic subtest: pipe-C-HDMI-A-4 [908.327575] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [908.340722] Starting dynamic subtest: pipe-D-HDMI-A-4 [908.354359] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [908.357154] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.014s) [908.539784] [116/134] (155s left) kms_cursor_crc (cursor-offscreen-128x42) [910.219060] Starting subtest: cursor-offscreen-128x42 [910.226381] Starting dynamic subtest: pipe-A-HDMI-A-4 [912.754920] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.529s) [912.792300] Starting dynamic subtest: pipe-D-HDMI-A-4 [915.170886] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.390s) [915.172358] Subtest cursor-offscreen-128x42: SUCCESS (4.951s) [915.622423] [117/134] (148s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [917.109882] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [917.111492] Starting dynamic subtest: pipe-A [917.224769] Dynamic subtest pipe-A: SUCCESS (0.117s) [917.238956] Starting dynamic subtest: pipe-B [917.366415] Dynamic subtest pipe-B: SUCCESS (0.141s) [917.381981] Starting dynamic subtest: pipe-C [917.507758] Dynamic subtest pipe-C: SUCCESS (0.140s) [917.521552] Starting dynamic subtest: pipe-D [917.648921] Dynamic subtest pipe-D: SUCCESS (0.140s) [917.650389] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.542s) [917.874076] [118/134] (145s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [919.379471] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [920.476608] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.093s) [920.645513] [119/134] (143s left) syncobj_basic (bad-pad-handle-to-fd) [920.691253] Starting subtest: bad-pad-handle-to-fd [920.693182] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [920.834063] [120/134] (143s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [922.319657] Starting subtest: cursorA-vs-flipB-atomic-transitions [922.322766] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.002s) [922.538810] [121/134] (141s left) kms_frontbuffer_tracking (psr-2p-rte) [924.029380] Starting subtest: psr-2p-rte [924.032454] Subtest psr-2p-rte: SKIP (0.000s) [924.300104] [122/134] (139s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [925.790661] Starting subtest: psr-shrfb-scaledprimary [925.793661] Subtest psr-shrfb-scaledprimary: SKIP (0.000s) [926.064830] [123/134] (138s left) gen7_exec_parse (cmd-crossing-page) [926.116783] Subtest cmd-crossing-page: SKIP (0.000s) [926.220483] [124/134] (138s left) kms_frontbuffer_tracking (fbc-1p-rte) [927.713181] Starting subtest: fbc-1p-rte [931.192452] Subtest fbc-1p-rte: SUCCESS (3.482s) [931.484385] [125/134] (133s left) gem_mmap_wc (write) [931.530333] Subtest write: SKIP (0.000s) [931.604741] [126/134] (132s left) kms_busy (extended-modeset-hang-newfb) [933.096737] Starting subtest: extended-modeset-hang-newfb [933.098518] Starting dynamic subtest: pipe-A [948.628276] Dynamic subtest pipe-A: SUCCESS (15.528s) [948.644794] Starting dynamic subtest: pipe-D [964.166301] Dynamic subtest pipe-D: SUCCESS (15.533s) [964.167606] Subtest extended-modeset-hang-newfb: SUCCESS (31.070s) [964.440555] [127/134] (100s left) i915_pm_rpm (gem-evict-pwrite) [968.561926] Starting subtest: gem-evict-pwrite [968.565475] Subtest gem-evict-pwrite: SKIP (0.000s) [969.483442] [128/134] ( 95s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [970.968275] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [970.969912] Starting dynamic subtest: pipe-A-HDMI-A-4 [970.984925] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s) [970.999267] Starting dynamic subtest: pipe-B-HDMI-A-4 [971.024642] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s) [971.037861] Starting dynamic subtest: pipe-C-HDMI-A-4 [971.052973] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s) [971.066755] Starting dynamic subtest: pipe-D-HDMI-A-4 [971.079293] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s) [971.080838] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.013s) [971.255689] [129/134] ( 93s left) i915_suspend (basic-s2idle-without-i915) [971.299285] Starting subtest: basic-s2idle-without-i915 [991.393534] Subtest basic-s2idle-without-i915: SUCCESS (5.540s) [994.523930] [130/134] ( 73s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [996.016207] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [996.020292] Starting dynamic subtest: pipe-A-valid-mode [997.135209] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.115s) [997.139448] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.118s) [997.321971] [131/134] ( 70s left) kms_big_fb (4-tiled-addfb) [998.846724] Starting subtest: 4-tiled-addfb [998.849737] Subtest 4-tiled-addfb: SKIP (0.000s) [999.097112] [132/134] ( 69s left) kms_setmode (basic-clone-single-crtc) [999.146351] Starting subtest: basic-clone-single-crtc [999.151411] Subtest basic-clone-single-crtc: SKIP (0.000s) [999.322749] [133/134] ( 68s left) gem_exec_balancer (full-late-pulse) [999.382418] Starting subtest: full-late-pulse [1001.733764] Subtest full-late-pulse: SUCCESS (2.351s) [1002.252860] [134/134] ( 66s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [1003.749135] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [1003.752281] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [1003.997246] 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.