[59.817927] Initializing watchdogs [59.818031] /dev/watchdog0 [59.836715] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.844320] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.848223] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.851599] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [59.973930] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [67.426021] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.481s) [67.793173] [002/134] (952s left) gem_exec_params (secure-non-master) [67.907067] Starting subtest: secure-non-master [67.911910] Subtest secure-non-master: SKIP (0.000s) [68.124534] [003/134] (952s left) tools_test (tools_test) [68.178466] Starting subtest: tools_test [68.225070] Subtest tools_test: SUCCESS (0.063s) [68.309129] [004/134] (952s left) kms_selftest (drm_cmdline_parser) [68.339174] Starting subtest: drm_cmdline_parser [68.348924] Starting dynamic subtest: drm_test_cmdline_force_d_only [68.473288] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.123s) [68.485513] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [68.612397] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.139s) [68.620174] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [68.743227] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.131s) [68.749511] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [68.849111] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.107s) [68.855845] Starting dynamic subtest: drm_test_cmdline_force_e_only [68.998318] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.148s) [69.006852] Starting dynamic subtest: drm_test_cmdline_res [69.154149] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.156s) [69.160224] Starting dynamic subtest: drm_test_cmdline_res_vesa [69.290142] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.136s) [69.296257] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [69.431118] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.141s) [69.437820] Starting dynamic subtest: drm_test_cmdline_res_rblank [69.543018] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.111s) [69.549737] Starting dynamic subtest: drm_test_cmdline_res_bpp [69.632596] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.090s) [69.640616] Starting dynamic subtest: drm_test_cmdline_res_refresh [69.797527] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.164s) [69.806108] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [69.946856] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.150s) [69.955613] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [70.090407] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.143s) [70.099072] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [70.230410] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.140s) [70.238897] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [70.371230] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.141s) [70.379717] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [70.505354] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.134s) [70.513806] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [70.648874] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.144s) [70.657534] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [70.785508] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.136s) [70.793978] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [70.924244] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.139s) [70.933060] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [71.060652] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.133s) [71.067709] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [71.191655] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.131s) [71.198606] Starting dynamic subtest: drm_test_cmdline_name [71.336351] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.146s) [71.343136] Starting dynamic subtest: drm_test_cmdline_name_bpp [71.485924] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.148s) [71.492103] Starting dynamic subtest: drm_test_cmdline_name_option [71.607904] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.122s) [71.614381] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [71.736530] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.128s) [71.745365] Starting dynamic subtest: drm_test_cmdline_rotate_0 [71.863481] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.127s) [71.872400] Starting dynamic subtest: drm_test_cmdline_rotate_90 [71.991911] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.129s) [72.000716] Starting dynamic subtest: drm_test_cmdline_rotate_180 [72.120271] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.128s) [72.129382] Starting dynamic subtest: drm_test_cmdline_rotate_270 [72.217175] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.096s) [72.225995] Starting dynamic subtest: drm_test_cmdline_hmirror [72.349354] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.133s) [72.356226] Starting dynamic subtest: drm_test_cmdline_vmirror [72.481960] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.132s) [72.488209] Starting dynamic subtest: drm_test_cmdline_margin_options [72.605197] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.123s) [72.612092] Starting dynamic subtest: drm_test_cmdline_multiple_options [72.754265] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.149s) [72.761181] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [72.896334] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.142s) [72.903423] Starting dynamic subtest: drm_test_cmdline_extra_and_option [73.016192] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.120s) [73.025487] Starting dynamic subtest: drm_test_cmdline_freestanding_options [73.150076] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.132s) [73.158600] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [73.277898] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.129s) [73.286068] Starting dynamic subtest: drm_test_cmdline_panel_orientation [73.415374] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.137s) [73.423587] Starting dynamic subtest: drm_test_cmdline_invalid [73.534146] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.120s) [73.540964] Starting dynamic subtest: drm_test_cmdline_tv_options [73.649186] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.114s) [73.651544] Subtest drm_cmdline_parser: SUCCESS (5.317s) [73.859791] [005/134] (946s left) gem_exec_suspend (basic-s0) [73.923638] Starting subtest: basic-S0 [73.926126] Starting dynamic subtest: smem [94.983254] Dynamic subtest smem: SUCCESS (7.043s) [94.987240] Subtest basic-S0: SUCCESS (7.044s) [95.183258] [006/134] (925s left) kms_content_protection (uevent) [95.344833] Starting subtest: uevent [95.349825] Subtest uevent: SKIP (0.001s) [95.507105] [007/134] (925s left) gem_eio (in-flight-suspend) [95.730851] Starting subtest: in-flight-suspend [138.611198] Subtest in-flight-suspend: SUCCESS (13.620s) [138.762980] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true [138.766078] [008/134] (881s left) gem_spin_batch (resubmit-all) [138.836982] Starting subtest: resubmit-all [138.839426] Starting dynamic subtest: rcs0 [138.847742] Dynamic subtest rcs0: SUCCESS (0.011s) [138.857924] Starting dynamic subtest: bcs0 [138.860203] Dynamic subtest bcs0: SUCCESS (0.003s) [138.868335] Starting dynamic subtest: vcs0 [138.870224] Dynamic subtest vcs0: SUCCESS (0.003s) [138.877374] Starting dynamic subtest: vcs1 [138.879258] Dynamic subtest vcs1: SUCCESS (0.002s) [138.886599] Starting dynamic subtest: vecs0 [138.888438] Dynamic subtest vecs0: SUCCESS (0.003s) [138.895849] Starting dynamic subtest: ccs0 [138.898175] Dynamic subtest ccs0: SUCCESS (0.002s) [138.900304] Subtest resubmit-all: SUCCESS (0.025s) [140.460025] [009/134] (880s left) kms_psr (psr-cursor-plane-onoff) [140.555872] Starting subtest: psr-cursor-plane-onoff [140.558200] Starting dynamic subtest: eDP-1 [142.279308] Dynamic subtest eDP-1: SUCCESS (1.772s) [142.281615] Subtest psr-cursor-plane-onoff: SUCCESS (1.773s) [143.134307] [010/134] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [143.244122] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [149.977552] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.836s) [150.124481] [011/134] (870s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [150.225661] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [150.229920] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [150.356903] [012/134] (870s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [155.337432] Starting subtest: fbc-psr2-cursor-plane-update-sf [155.339743] Starting dynamic subtest: pipe-A-eDP-1 [156.133319] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s) [156.143263] Starting dynamic subtest: pipe-B-eDP-1 [157.256965] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s) [157.261125] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.925s) [158.478246] [013/134] (862s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [163.541459] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [163.543913] Starting dynamic subtest: pipe-A-eDP-1 [170.140129] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.605s) [170.149468] Starting dynamic subtest: pipe-B-eDP-1 [176.769076] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.625s) [176.771468] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.234s) [177.646048] [014/134] (843s left) kms_pm_rpm (basic-pci-d3-state) [179.506073] Starting subtest: basic-pci-d3-state [180.966436] Subtest basic-pci-d3-state: SUCCESS (1.460s) [181.077126] [015/134] (839s left) gem_ctx_exec (basic-norecovery) [181.150657] Starting subtest: basic-norecovery [181.503200] Subtest basic-norecovery: SUCCESS (0.352s) [181.659042] [016/134] (839s left) gem_pxp (protected-encrypted-src-copy-not-readible) [181.790012] Starting subtest: protected-encrypted-src-copy-not-readible [181.906972] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.117s) [182.061339] [017/134] (838s left) kms_flip (absolute-wf_vblank) [182.174728] Starting subtest: absolute-wf_vblank [182.177021] Starting dynamic subtest: A-eDP1 [190.882622] Dynamic subtest A-eDP1: SUCCESS (8.705s) [190.892980] Starting dynamic subtest: B-eDP1 [199.600828] Dynamic subtest B-eDP1: SUCCESS (8.717s) [199.611390] Starting dynamic subtest: C-eDP1 [208.314272] Dynamic subtest C-eDP1: SUCCESS (8.713s) [208.323167] Starting dynamic subtest: D-eDP1 [217.038742] Dynamic subtest D-eDP1: SUCCESS (8.726s) [217.043300] Subtest absolute-wf_vblank: SUCCESS (34.870s) [218.278143] [018/134] (802s left) prime_mmap (test_refcounting) [218.338504] Starting subtest: test_refcounting [218.340431] Starting dynamic subtest: test_refcounting-smem [218.365896] Dynamic subtest test_refcounting-smem: SUCCESS (0.029s) [218.368303] Subtest test_refcounting: SUCCESS (0.030s) [218.495867] [019/134] (802s left) gem_exec_schedule (pi-common) [218.682117] Starting subtest: pi-common [218.684615] Starting dynamic subtest: rcs0 [218.714285] Dynamic subtest rcs0: SUCCESS (0.034s) [218.723223] Starting dynamic subtest: bcs0 [218.744821] Dynamic subtest bcs0: SUCCESS (0.030s) [218.753067] Starting dynamic subtest: vcs0 [218.774160] Dynamic subtest vcs0: SUCCESS (0.029s) [218.786202] Starting dynamic subtest: vcs1 [218.800937] Dynamic subtest vcs1: SUCCESS (0.026s) [218.812582] Starting dynamic subtest: vecs0 [218.828495] Dynamic subtest vecs0: SUCCESS (0.027s) [218.841121] Starting dynamic subtest: ccs0 [218.854846] Dynamic subtest ccs0: SUCCESS (0.026s) [218.857037] Subtest pi-common: SUCCESS (0.175s) [219.117476] [020/134] (802s left) perf (unprivileged-single-ctx-counters) [219.256070] Starting subtest: unprivileged-single-ctx-counters [219.260342] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [219.302946] [021/134] (801s left) api_intel_allocator (fork-simple-stress-signal) [219.361740] Starting subtest: fork-simple-stress-signal [224.762120] Subtest fork-simple-stress-signal: SUCCESS (5.402s) [224.910856] [022/134] (796s left) kms_flip (flip-vs-panning-vs-hang) [225.027541] Starting subtest: flip-vs-panning-vs-hang [225.029750] Starting dynamic subtest: A-eDP1 [275.875199] Dynamic subtest A-eDP1: SUCCESS (50.840s) [275.886332] Starting dynamic subtest: D-eDP1 [315.875519] Dynamic subtest D-eDP1: SUCCESS (40.002s) [315.878447] Subtest flip-vs-panning-vs-hang: SUCCESS (90.847s) [317.137863] [023/134] (704s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [322.127147] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [322.129490] Starting dynamic subtest: pipe-A-eDP-1 [334.156916] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.030s) [334.167065] Starting dynamic subtest: pipe-B-eDP-1 [346.174832] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.018s) [346.177181] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.052s) [347.027978] [024/134] (674s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [347.093676] Starting subtest: invalid-multi-wait-unsubmitted-submitted [347.096058] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [347.214062] [025/134] (674s left) gem_exec_create (basic) [347.268813] Starting subtest: basic [347.271174] Starting dynamic subtest: smem [350.397026] Dynamic subtest smem: SUCCESS (3.127s) [350.399615] Subtest basic: SUCCESS (3.128s) [350.595922] [026/134] (670s left) gem_ctx_persistence (smoketest) [350.658194] Starting subtest: smoketest [391.324072] Subtest smoketest: SUCCESS (40.662s) [391.471023] [027/134] (629s left) gem_ctx_bad_destroy (invalid-pad) [391.518763] Starting subtest: invalid-pad [391.521206] Subtest invalid-pad: SUCCESS (0.000s) [391.605196] [028/134] (629s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [391.740014] Starting subtest: cursorA-vs-flipB-legacy [391.744770] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [391.901864] [029/134] (629s left) kms_atomic_interruptible (legacy-setmode) [391.996869] Starting subtest: legacy-setmode [391.999093] Starting dynamic subtest: pipe-A-eDP-1 [398.913809] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.914s) [398.915756] Subtest legacy-setmode: SUCCESS (6.916s) [399.777606] [030/134] (621s left) kms_cdclk (mode-transition) [399.889987] Starting subtest: mode-transition [399.892357] Starting dynamic subtest: pipe-A-eDP-1 [400.177498] Dynamic subtest pipe-A-eDP-1: SKIP (0.285s) [400.187916] Starting dynamic subtest: pipe-B-eDP-1 [400.192922] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [400.203813] Starting dynamic subtest: pipe-C-eDP-1 [400.208639] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [400.222590] Starting dynamic subtest: pipe-D-eDP-1 [400.226765] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [400.230878] Subtest mode-transition: SKIP (0.293s) [401.011619] [031/134] (620s left) kms_big_fb (linear-8bpp-rotate-270) [401.105582] Starting subtest: linear-8bpp-rotate-270 [401.127001] Subtest linear-8bpp-rotate-270: SKIP (0.021s) [401.276658] [032/134] (620s left) perf_pmu (faulting-read) [401.318023] Starting subtest: faulting-read [401.320260] Starting dynamic subtest: wb [401.322616] Dynamic subtest wb: SUCCESS (0.001s) [401.333555] Starting dynamic subtest: wc [401.335358] Dynamic subtest wc: SUCCESS (0.000s) [401.343461] Starting dynamic subtest: uc [401.345314] Dynamic subtest uc: SUCCESS (0.000s) [401.347591] Subtest faulting-read: SUCCESS (0.003s) [401.457680] [033/134] (620s left) kms_psr (fbc-psr2-primary-render) [401.548447] Starting subtest: fbc-psr2-primary-render [401.550777] Starting dynamic subtest: eDP-1 [401.555085] Dynamic subtest eDP-1: SKIP (0.000s) [401.559479] Subtest fbc-psr2-primary-render: SKIP (0.001s) [401.646522] [034/134] (620s left) gem_exec_schedule (deep) [401.832636] Starting subtest: deep [401.835137] Starting dynamic subtest: rcs0 [407.012974] Dynamic subtest rcs0: SKIP (5.177s) [407.024379] Starting dynamic subtest: vcs0 [417.984174] Dynamic subtest vcs0: SUCCESS (10.972s) [417.998059] Starting dynamic subtest: vcs1 [429.525787] Dynamic subtest vcs1: SUCCESS (11.540s) [429.541637] Starting dynamic subtest: vecs0 [440.785779] Dynamic subtest vecs0: SUCCESS (11.259s) [440.800589] Starting dynamic subtest: ccs0 [453.398081] Dynamic subtest ccs0: SUCCESS (12.611s) [453.400773] Subtest deep: SUCCESS (51.565s) [454.287590] [035/134] (567s left) kms_selftest (drm_plane_helper) [454.324573] Starting subtest: drm_plane_helper [454.391831] Starting dynamic subtest: drm_test_check_plane_state [454.552795] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.160s) [454.561624] Starting dynamic subtest: drm_test_check_invalid_plane_state [454.690019] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.137s) [454.692463] Subtest drm_plane_helper: SUCCESS (0.367s) [454.931895] [036/134] (566s left) syncobj_basic (bad-pad-fd-to-handle) [454.986613] Starting subtest: bad-pad-fd-to-handle [454.989040] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [455.105742] [037/134] (566s left) gem_lmem_swapping (parallel-random-engines) [455.148887] Subtest parallel-random-engines: SKIP (0.000s) [455.194796] [038/134] (566s left) kms_mmap_write_crc (main) [455.296720] Starting subtest: main [455.299000] Starting dynamic subtest: pipe-A-eDP-1 [458.905722] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.607s) [458.907923] Subtest main: SUCCESS (3.609s) [459.727426] [039/134] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [459.841544] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [466.587711] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.750s) [466.763230] [040/134] (555s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [466.863819] Starting subtest: addfb25-yf-tiled-legacy [466.866137] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [466.982997] [041/134] (554s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [467.083184] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [467.087299] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [467.206826] [042/134] (554s left) gem_ctx_exec (basic) [467.264129] Starting subtest: basic [467.269963] Subtest basic: SUCCESS (0.008s) [467.408275] [043/134] (554s left) kms_atomic (test-only) [467.507807] Starting subtest: test-only [467.556325] Starting dynamic subtest: pipe-A-eDP-1 [470.059841] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s) [470.061996] Subtest test-only: SUCCESS (2.553s) [470.937066] [044/134] (551s left) gem_set_tiling_vs_gtt [471.058781] [045/134] (551s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [471.164161] Starting subtest: yf-tiled-16bpp-rotate-0 [471.168567] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [471.305205] [046/134] (550s left) kms_getfb (getfb2-handle-zero) [471.400317] Starting subtest: getfb2-handle-zero [471.402644] Subtest getfb2-handle-zero: SUCCESS (0.000s) [471.536869] [047/134] (550s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [471.590650] Starting subtest: single-wait-all-for-submit-available-submitted [471.593157] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [471.742813] [048/134] (550s left) gem_exec_reloc (basic-wc-cpu) [471.809582] Subtest basic-wc-cpu: SKIP (0.000s) [471.882384] [049/134] (550s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [472.004838] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [479.190614] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.190s) [479.355466] [050/134] (542s left) gem_basic (multigpu-create-close) [479.408592] Starting subtest: multigpu-create-close [479.412625] Subtest multigpu-create-close: SKIP (0.000s) [479.515056] [051/134] (542s left) kms_frontbuffer_tracking (fbc-suspend) [479.613814] Starting subtest: fbc-suspend [517.498567] Subtest fbc-suspend: SUCCESS (7.545s) [518.677028] [052/134] (503s left) gem_wait (wait) [518.751547] Starting subtest: wait [518.753886] Starting dynamic subtest: all-engines [520.871246] Dynamic subtest all-engines: SUCCESS (2.155s) [520.882512] Starting dynamic subtest: rcs0 [521.917491] Dynamic subtest rcs0: SUCCESS (1.060s) [521.933491] Starting dynamic subtest: bcs0 [522.965089] Dynamic subtest bcs0: SUCCESS (1.058s) [522.979112] Starting dynamic subtest: vcs0 [524.011921] Dynamic subtest vcs0: SUCCESS (1.055s) [524.026249] Starting dynamic subtest: vcs1 [525.058029] Dynamic subtest vcs1: SUCCESS (1.053s) [525.068675] Starting dynamic subtest: vecs0 [526.102192] Dynamic subtest vecs0: SUCCESS (1.051s) [526.113628] Starting dynamic subtest: ccs0 [527.148976] Dynamic subtest ccs0: SUCCESS (1.052s) [527.151565] Subtest wait: SUCCESS (8.501s) [527.357530] [053/134] (495s left) gem_exec_reloc (basic-wc-active) [527.414225] Subtest basic-wc-active: SKIP (0.000s) [527.496194] [054/134] (495s left) kms_pm_rpm (pc8-residency) [529.016611] Starting subtest: pc8-residency [529.021552] Subtest pc8-residency: SKIP (0.000s) [529.796284] [055/134] (492s left) kms_dsc (dsc-with-bpc-formats) [529.889736] Starting subtest: dsc-with-bpc-formats [529.999973] Subtest dsc-with-bpc-formats: SKIP (0.003s) [530.042514] [056/134] (492s left) kms_psr (pr-cursor-plane-move) [530.145893] Starting subtest: pr-cursor-plane-move [530.150015] Subtest pr-cursor-plane-move: SKIP (0.000s) [530.227879] [057/134] (492s left) kms_vblank (ts-continuation-dpms-suspend) [530.330535] Starting subtest: ts-continuation-dpms-suspend [530.332793] Starting dynamic subtest: pipe-A-eDP-1 [547.654129] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.818s) [547.669785] Starting dynamic subtest: pipe-D-eDP-1 [565.749722] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.630s) [565.752096] Subtest ts-continuation-dpms-suspend: SUCCESS (4.454s) [566.665747] [058/134] (456s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [566.744346] Starting subtest: multi-wait-available-unsubmitted-signaled [566.746518] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [566.891660] [059/134] (455s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [567.021955] Starting subtest: basic-flip-before-cursor-legacy [567.926776] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.926s) [568.722810] [060/134] (454s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [569.097961] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [569.896787] [061/134] (452s left) gem_exec_params (invalid-flag) [569.963214] Starting subtest: invalid-flag [569.965455] Subtest invalid-flag: SUCCESS (0.000s) [570.088705] [062/134] (452s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [570.192929] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [570.196853] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [570.297028] [063/134] (452s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [570.352267] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [570.354436] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [570.446150] [064/134] (452s left) prime_vgem (wait) [570.523664] Starting subtest: wait [570.525983] Starting dynamic subtest: rcs0 [570.583499] Dynamic subtest rcs0: SUCCESS (0.061s) [570.593328] Starting dynamic subtest: bcs0 [570.643647] Dynamic subtest bcs0: SUCCESS (0.060s) [570.652446] Starting dynamic subtest: vcs0 [570.690620] Dynamic subtest vcs0: SUCCESS (0.047s) [570.699503] Starting dynamic subtest: vcs1 [570.738119] Dynamic subtest vcs1: SUCCESS (0.047s) [570.746902] Starting dynamic subtest: vecs0 [570.781686] Dynamic subtest vecs0: SUCCESS (0.043s) [570.790652] Starting dynamic subtest: ccs0 [570.829644] Dynamic subtest ccs0: SUCCESS (0.048s) [570.831557] Subtest wait: SUCCESS (0.312s) [570.976339] [065/134] (451s left) gem_exec_capture (capture) [571.036153] Starting subtest: capture [571.038261] Starting dynamic subtest: rcs0-smem [571.847249] Dynamic subtest rcs0-smem: SUCCESS (0.822s) [571.856045] Starting dynamic subtest: bcs0-smem [572.653519] Dynamic subtest bcs0-smem: SUCCESS (0.815s) [572.664539] Starting dynamic subtest: vcs0-smem [573.455866] Dynamic subtest vcs0-smem: SUCCESS (0.810s) [573.466408] Starting dynamic subtest: vcs1-smem [574.761625] Dynamic subtest vcs1-smem: SUCCESS (1.321s) [574.773627] Starting dynamic subtest: vecs0-smem [575.651695] Dynamic subtest vecs0-smem: FAIL (0.839s) [575.662607] Starting dynamic subtest: ccs0-smem [576.917589] Dynamic subtest ccs0-smem: SUCCESS (1.332s) [576.920009] Subtest capture: FAIL (5.943s) [577.075736] [066/134] (445s left) kms_cursor_crc (cursor-rapid-movement-512x512) [577.380861] Starting subtest: cursor-rapid-movement-512x512 [577.385377] Subtest cursor-rapid-movement-512x512: SKIP (0.002s) [577.548326] [067/134] (445s left) kms_flip (2x-flip-vs-wf_vblank) [577.647807] Starting subtest: 2x-flip-vs-wf_vblank [577.656234] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s) [577.760883] [068/134] (445s left) i915_pm_freq_api (freq-suspend) [577.819457] Starting subtest: freq-suspend [577.821447] Starting dynamic subtest: gt0 [594.104343] Dynamic subtest gt0: SUCCESS (1.213s) [594.123365] Starting dynamic subtest: gt1 [610.146492] Dynamic subtest gt1: SUCCESS (1.255s) [610.149033] Subtest freq-suspend: SUCCESS (2.472s) [610.241396] [069/134] (412s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [610.352979] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [610.358609] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [610.472236] [070/134] (412s left) kms_chamelium_frames (hdmi-aspect-ratio) [610.882061] Subtest hdmi-aspect-ratio: SKIP (0.000s) [611.665856] [071/134] (411s left) kms_cursor_crc (cursor-sliding-max-size) [611.981870] Starting subtest: cursor-sliding-max-size [611.989495] Subtest cursor-sliding-max-size: SKIP (0.000s) [612.177658] [072/134] (411s left) kms_color_pipeline (plane-ctm3x4-lut1d) [612.288692] Starting subtest: plane-ctm3x4-lut1d [612.303691] Starting dynamic subtest: pipe-A-eDP-1 [612.981698] Dynamic subtest pipe-A-eDP-1: FAIL (0.316s) [613.688406] Starting dynamic subtest: pipe-B-eDP-1 [614.632258] Dynamic subtest pipe-B-eDP-1: FAIL (0.362s) [615.097525] Starting dynamic subtest: pipe-C-eDP-1 [616.001653] Dynamic subtest pipe-C-eDP-1: FAIL (0.245s) [616.400342] Starting dynamic subtest: pipe-D-eDP-1 [617.360414] Dynamic subtest pipe-D-eDP-1: FAIL (0.279s) [617.362927] Subtest plane-ctm3x4-lut1d: FAIL (4.745s) [617.781424] [073/134] (405s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [617.901435] Starting subtest: psr-1p-pri-indfb-multidraw [640.440632] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.639s) [640.579845] [074/134] (382s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [640.686811] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [640.691072] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [640.797340] [075/134] (382s left) syncobj_timeline (invalid-query-illegal-handle) [640.856565] Starting subtest: invalid-query-illegal-handle [640.858654] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [640.972967] [076/134] (382s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [641.061943] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [641.064197] Starting dynamic subtest: pipe-A-eDP-1 [643.172460] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s) [643.181683] Starting dynamic subtest: pipe-B-eDP-1 [645.405991] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.233s) [645.417401] Starting dynamic subtest: pipe-C-eDP-1 [647.512334] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.100s) [647.534562] Starting dynamic subtest: pipe-D-eDP-1 [649.522661] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.011s) [649.525582] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.462s) [650.784239] [077/134] (372s left) kms_addfb_basic (too-high) [650.894780] Starting subtest: too-high [650.897599] Subtest too-high: SUCCESS (0.000s) [650.999295] [078/134] (372s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [651.110239] Starting subtest: psr-rgb565-draw-mmap-gtt [651.115699] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [651.236441] [079/134] (372s left) gem_mmap_offset (mmap-unmap) [651.302953] Starting subtest: mmap-unmap [651.305630] Starting dynamic subtest: smem0 [673.926673] Dynamic subtest smem0: SUCCESS (22.631s) [673.929461] Subtest mmap-unmap: SUCCESS (22.632s) [674.045665] [080/134] (349s left) gem_pread (exhaustion) [674.108714] Subtest exhaustion: SKIP (0.000s) [674.175367] [081/134] (349s left) kms_joiner (invalid-modeset-ultra-joiner) [674.276717] Starting subtest: invalid-modeset-ultra-joiner [674.281996] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [674.350272] [082/134] (349s left) i915_drm_fdinfo (basics) [674.391230] Starting subtest: basics [674.393720] Subtest basics: SUCCESS (0.000s) [674.474514] [083/134] (349s left) gem_ccs (ctrl-surf-copy-new-ctx) [674.520028] Starting subtest: ctrl-surf-copy-new-ctx [674.525484] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [674.649201] [084/134] (349s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [674.748535] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [674.774699] Starting dynamic subtest: pipe-A-plane-0 [675.451853] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s) [675.461580] Starting dynamic subtest: pipe-A-plane-3 [675.873822] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s) [675.889944] Starting dynamic subtest: pipe-A-plane-5 [675.895210] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [676.974889] Starting dynamic subtest: pipe-B-plane-0 [677.626293] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s) [677.636266] Starting dynamic subtest: pipe-B-plane-3 [678.058705] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s) [678.067768] Starting dynamic subtest: pipe-B-plane-5 [678.071407] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [678.379943] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.634s) [679.276008] [085/134] (344s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [679.377104] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [679.381783] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [679.497396] [086/134] (344s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [679.586374] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [679.588640] Starting dynamic subtest: pipe-A-default-mode [680.713693] Dynamic subtest pipe-A-default-mode: SKIP (1.126s) [680.718568] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.127s) [680.901475] [087/134] (343s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [681.010299] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [681.014883] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [681.128538] [088/134] (342s left) kms_draw_crc (fill-fb) [681.222660] Starting subtest: fill-fb [681.684551] Subtest fill-fb: SUCCESS (0.464s) [681.801604] [089/134] (342s left) kms_big_fb (y-tiled-8bpp-rotate-0) [681.897233] Starting subtest: y-tiled-8bpp-rotate-0 [681.901118] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [681.998042] [090/134] (342s left) gem_render_copy (yf-tiled-to-vebox-linear) [682.067216] Starting subtest: yf-tiled-to-vebox-linear [682.072277] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [682.263854] [091/134] (341s left) syncobj_wait (invalid-reset-illegal-handle) [682.326838] Starting subtest: invalid-reset-illegal-handle [682.329971] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [682.430240] [092/134] (341s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [682.531747] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [689.354790] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.828s) [689.536402] [093/134] (334s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [689.660770] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [689.665765] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [689.767152] [094/134] (334s left) api_intel_bb (full-batch) [689.828637] Starting subtest: full-batch [689.831058] Subtest full-batch: SUCCESS (0.006s) [689.997961] [095/134] (334s left) kms_psr (fbc-psr-basic) [690.087704] Starting subtest: fbc-psr-basic [690.090232] Starting dynamic subtest: eDP-1 [690.094789] Dynamic subtest eDP-1: SKIP (0.000s) [690.099832] Subtest fbc-psr-basic: SKIP (0.001s) [690.169292] [096/134] (334s left) gem_exercise_blt (fast-copy-emit) [690.218579] Starting subtest: fast-copy-emit [690.220806] Starting dynamic subtest: linear-smem-smem-emit [690.241921] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s) [690.251823] Starting dynamic subtest: xmajor-smem-smem-emit [690.258657] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s) [690.267646] Starting dynamic subtest: tile4-smem-smem-emit [690.274787] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s) [690.283592] Starting dynamic subtest: tile64-smem-smem-emit [690.290665] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s) [690.293282] Subtest fast-copy-emit: SUCCESS (0.073s) [690.443567] [097/134] (333s left) sysfs_heartbeat_interval (mixed) [690.497392] Starting subtest: mixed [690.499640] Starting dynamic subtest: vecs0 [695.735018] Dynamic subtest vecs0: SUCCESS (5.238s) [695.746742] Starting dynamic subtest: ccs0 [700.972450] Dynamic subtest ccs0: SUCCESS (5.238s) [700.984280] Starting dynamic subtest: vcs0 [706.202968] Dynamic subtest vcs0: SUCCESS (5.229s) [706.214975] Starting dynamic subtest: bcs0 [711.442541] Dynamic subtest bcs0: SUCCESS (5.233s) [711.454761] Starting dynamic subtest: rcs0 [716.631279] Dynamic subtest rcs0: SUCCESS (5.183s) [716.643329] Starting dynamic subtest: vcs1 [721.851795] Dynamic subtest vcs1: SUCCESS (5.217s) [721.854981] Subtest mixed: SUCCESS (31.351s) [721.944535] [098/134] (302s left) kms_cursor_legacy (cursor-vs-flip-legacy) [722.071271] Starting subtest: cursor-vs-flip-legacy [751.315005] Subtest cursor-vs-flip-legacy: SUCCESS (29.239s) [752.169296] [099/134] (272s left) gem_exec_schedule (semaphore-resolve) [752.250993] Starting subtest: semaphore-resolve [752.281093] Subtest semaphore-resolve: SUCCESS (0.038s) [752.650390] [100/134] (271s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [752.748849] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [752.753757] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [752.880081] [101/134] (271s left) kms_cursor_legacy (torture-bo) [753.011240] Starting subtest: torture-bo [753.013800] Starting dynamic subtest: pipe-A [759.937888] Dynamic subtest pipe-A: SUCCESS (6.924s) [759.950404] Starting dynamic subtest: pipe-B [765.863628] Dynamic subtest pipe-B: SUCCESS (5.926s) [765.875928] Starting dynamic subtest: pipe-C [772.143465] Dynamic subtest pipe-C: SUCCESS (6.278s) [772.160166] Starting dynamic subtest: pipe-D [779.921744] Dynamic subtest pipe-D: SUCCESS (7.778s) [779.931354] Starting dynamic subtest: all-pipes [787.725802] Dynamic subtest all-pipes: SUCCESS (7.802s) [787.728648] Subtest torture-bo: SUCCESS (34.718s) [787.906786] [102/134] (236s left) gem_ctx_shared (q-independent) [787.987563] Starting subtest: Q-independent [787.989980] Starting dynamic subtest: rcs0 [788.056023] Dynamic subtest rcs0: SUCCESS (0.066s) [788.069756] Starting dynamic subtest: vcs0 [788.094744] Dynamic subtest vcs0: SUCCESS (0.038s) [788.106570] Starting dynamic subtest: vcs1 [788.131723] Dynamic subtest vcs1: SUCCESS (0.036s) [788.142016] Starting dynamic subtest: vecs0 [788.184097] Dynamic subtest vecs0: SUCCESS (0.052s) [788.197632] Starting dynamic subtest: ccs0 [788.226475] Dynamic subtest ccs0: SUCCESS (0.042s) [788.228965] Subtest Q-independent: SUCCESS (0.238s) [789.912598] [103/134] (234s left) gem_exec_fence (syncobj-timeline-invalid-wait) [790.498439] Starting subtest: syncobj-timeline-invalid-wait [790.501224] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.007s) [791.895289] [104/134] (232s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [791.966941] Starting subtest: y-tiled-ccs-to-x-tiled [791.972712] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [792.165301] [105/134] (232s left) drm_read (short-buffer-wakeup) [792.323834] Starting subtest: short-buffer-wakeup [824.532687] Subtest short-buffer-wakeup: SUCCESS (32.218s) [824.699718] [106/134] (200s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [824.803527] Starting subtest: plane-use-after-nonblocking-unbind-fencing [824.805878] Starting dynamic subtest: pipe-A-eDP-1 [824.863829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [825.162065] Starting dynamic subtest: pipe-B-eDP-1 [825.941631] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.791s) [826.226972] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.426s) [827.117982] [107/134] (197s left) syncobj_timeline (device-submit-unordered) [827.192844] Starting subtest: device-submit-unordered [827.195699] Subtest device-submit-unordered: SUCCESS (0.000s) [827.319420] [108/134] (197s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [827.404741] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [827.407675] Starting dynamic subtest: pipe-A-eDP-1 [827.707485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.266s) [827.718955] Starting dynamic subtest: pipe-B-eDP-1 [829.025751] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.322s) [829.037424] Starting dynamic subtest: pipe-C-eDP-1 [830.296676] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.272s) [830.307171] Starting dynamic subtest: pipe-D-eDP-1 [831.518265] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s) [831.520606] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.080s) [832.756651] [109/134] (192s left) kms_pipe_crc_basic (nonblocking-crc) [832.864591] Starting subtest: nonblocking-crc [832.867291] Starting dynamic subtest: pipe-A-eDP-1 [833.600660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s) [833.611592] Starting dynamic subtest: pipe-B-eDP-1 [835.094966] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.492s) [835.104432] Starting dynamic subtest: pipe-C-eDP-1 [836.439774] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.341s) [836.450460] Starting dynamic subtest: pipe-D-eDP-1 [837.777941] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s) [837.780342] Subtest nonblocking-crc: SUCCESS (4.910s) [838.594478] [110/134] (186s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [838.693541] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [838.698725] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [838.807756] [111/134] (186s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [838.916712] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [838.921419] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [839.033222] [112/134] (185s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [839.124189] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [839.150884] Starting dynamic subtest: pipe-A-plane-0 [839.156954] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [839.178625] Starting dynamic subtest: pipe-A-plane-3 [839.183835] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [839.195073] Starting dynamic subtest: pipe-A-plane-5 [839.199862] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [840.277770] Starting dynamic subtest: pipe-B-plane-0 [840.281788] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [840.290570] Starting dynamic subtest: pipe-B-plane-3 [840.295137] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [840.305774] Starting dynamic subtest: pipe-B-plane-5 [840.310823] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [840.585950] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (1.458s) [841.478724] [113/134] (183s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [841.569797] Starting subtest: plane-downscale-factor-0-5-with-rotation [841.572382] Starting dynamic subtest: pipe-A [841.591560] Dynamic subtest pipe-A: SKIP (0.017s) [841.601678] Starting dynamic subtest: pipe-B [841.619665] Dynamic subtest pipe-B: SKIP (0.029s) [841.628562] Starting dynamic subtest: pipe-C [841.651486] Dynamic subtest pipe-C: SKIP (0.030s) [841.660539] Starting dynamic subtest: pipe-D [841.680952] Dynamic subtest pipe-D: SKIP (0.029s) [841.685614] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.108s) [841.806397] [114/134] (183s left) perf_pmu (busy-hang) [841.846785] Starting subtest: busy-hang [841.849609] Starting dynamic subtest: rcs0 [843.104415] Dynamic subtest rcs0: SUCCESS (1.259s) [843.117123] Starting dynamic subtest: bcs0 [844.342435] Dynamic subtest bcs0: SUCCESS (1.233s) [844.354071] Starting dynamic subtest: vcs0 [846.312009] Dynamic subtest vcs0: SUCCESS (1.967s) [846.322358] Starting dynamic subtest: vcs1 [848.295805] Dynamic subtest vcs1: SUCCESS (1.981s) [848.307093] Starting dynamic subtest: vecs0 [850.274307] Dynamic subtest vecs0: SUCCESS (1.979s) [850.286221] Starting dynamic subtest: ccs0 [851.509218] Dynamic subtest ccs0: SUCCESS (1.233s) [851.512219] Subtest busy-hang: SUCCESS (9.663s) [851.658116] [115/134] (173s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [851.760843] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [851.763261] Starting dynamic subtest: pipe-A-eDP-1 [852.561447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.793s) [852.571185] Starting dynamic subtest: pipe-B-eDP-1 [854.059354] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s) [854.069941] Starting dynamic subtest: pipe-C-eDP-1 [855.574514] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.512s) [855.585686] Starting dynamic subtest: pipe-D-eDP-1 [857.118865] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.543s) [857.121705] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.348s) [858.309291] [116/134] (166s left) kms_cursor_crc (cursor-offscreen-128x42) [858.548963] Starting subtest: cursor-offscreen-128x42 [858.625685] Subtest cursor-offscreen-128x42: SKIP (0.074s) [858.880545] [117/134] (166s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [858.985937] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [858.988698] Starting dynamic subtest: pipe-A [859.006093] Dynamic subtest pipe-A: SKIP (0.017s) [859.015875] Starting dynamic subtest: pipe-B [859.040707] Dynamic subtest pipe-B: SKIP (0.031s) [859.050687] Starting dynamic subtest: pipe-C [859.072474] Dynamic subtest pipe-C: SKIP (0.031s) [859.081945] Starting dynamic subtest: pipe-D [859.103047] Dynamic subtest pipe-D: SKIP (0.030s) [859.107855] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.113s) [859.223837] [118/134] (165s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [859.326451] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [860.327396] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.000s) [860.462781] [119/134] (164s left) syncobj_basic (bad-pad-handle-to-fd) [860.517950] Starting subtest: bad-pad-handle-to-fd [860.520785] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [860.641207] [120/134] (164s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [860.755529] Starting subtest: cursorA-vs-flipB-atomic-transitions [860.759512] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [860.924515] [121/134] (164s left) kms_frontbuffer_tracking (psr-2p-rte) [861.024689] Starting subtest: psr-2p-rte [861.028701] Subtest psr-2p-rte: SKIP (0.000s) [861.124295] [122/134] (164s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [861.219747] Starting subtest: psr-shrfb-scaledprimary [867.034105] Subtest psr-shrfb-scaledprimary: SUCCESS (5.816s) [867.191342] [123/134] (158s left) gen7_exec_parse (cmd-crossing-page) [867.254621] Subtest cmd-crossing-page: SKIP (0.000s) [867.314018] [124/134] (158s left) kms_frontbuffer_tracking (fbc-1p-rte) [867.424766] Starting subtest: fbc-1p-rte [872.898392] Subtest fbc-1p-rte: SUCCESS (5.484s) [874.124842] [125/134] (151s left) gem_mmap_wc (write) [874.186817] Subtest write: SKIP (0.000s) [874.259047] [126/134] (151s left) kms_busy (extended-modeset-hang-newfb) [874.351889] Starting subtest: extended-modeset-hang-newfb [874.354707] Starting dynamic subtest: pipe-A [909.686722] Dynamic subtest pipe-A: SUCCESS (35.332s) [909.698704] Starting dynamic subtest: pipe-D [932.645089] Dynamic subtest pipe-D: SUCCESS (22.955s) [932.647917] Subtest extended-modeset-hang-newfb: SUCCESS (58.291s) [933.451962] [127/134] ( 92s left) i915_pm_rpm (gem-evict-pwrite) [934.977926] Starting subtest: gem-evict-pwrite [934.983363] Subtest gem-evict-pwrite: SKIP (0.000s) [935.705547] [128/134] ( 89s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [935.805874] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [935.808670] Starting dynamic subtest: pipe-A-eDP-1 [935.836685] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [935.853936] Starting dynamic subtest: pipe-B-eDP-1 [935.883782] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [935.895049] Starting dynamic subtest: pipe-C-eDP-1 [935.921381] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [935.930806] Starting dynamic subtest: pipe-D-eDP-1 [935.956511] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [935.961576] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s) [938.061729] [129/134] ( 87s left) i915_suspend (basic-s2idle-without-i915) [938.102825] Starting subtest: basic-s2idle-without-i915 [958.812799] Subtest basic-s2idle-without-i915: SUCCESS (5.469s) [958.946476] [130/134] ( 66s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [959.057570] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [959.060020] Starting dynamic subtest: pipe-A-default-mode [961.781670] Dynamic subtest pipe-A-default-mode: SUCCESS (2.715s) [961.784639] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.716s) [962.638353] [131/134] ( 63s left) kms_big_fb (4-tiled-addfb) [962.741453] Starting subtest: 4-tiled-addfb [962.743819] Subtest 4-tiled-addfb: SUCCESS (0.000s) [962.860212] [132/134] ( 62s left) kms_setmode (basic-clone-single-crtc) [962.916083] Starting subtest: basic-clone-single-crtc [962.924550] Subtest basic-clone-single-crtc: SKIP (0.000s) [963.019101] [133/134] ( 62s left) gem_exec_balancer (full-late-pulse) [963.082244] Starting subtest: full-late-pulse [967.851918] Subtest full-late-pulse: SUCCESS (4.761s) [968.214505] [134/134] ( 57s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [968.318543] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [968.323586] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [968.434265] 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.