[58.113598] Initializing watchdogs [58.113674] /dev/watchdog0 [58.127850] [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] [58.132220] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.134370] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.136127] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [58.242712] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [65.588116] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.359s) [65.734725] [002/134] (952s left) gem_exec_params (secure-non-master) [65.795915] Starting subtest: secure-non-master [65.797598] Subtest secure-non-master: SKIP (0.000s) [65.903080] [003/134] (952s left) tools_test (tools_test) [65.937888] Starting subtest: tools_test [65.997328] Subtest tools_test: SUCCESS (0.064s) [66.063684] [004/134] (952s left) kms_selftest (drm_cmdline_parser) [66.105805] Starting subtest: drm_cmdline_parser [66.117343] Starting dynamic subtest: drm_test_cmdline_force_d_only [66.237595] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.122s) [66.244667] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [66.373558] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.136s) [66.380717] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [66.486276] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.113s) [66.493157] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [66.635444] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.149s) [66.642467] Starting dynamic subtest: drm_test_cmdline_force_e_only [66.826595] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.191s) [66.833882] Starting dynamic subtest: drm_test_cmdline_res [67.530443] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.703s) [67.538364] Starting dynamic subtest: drm_test_cmdline_res_vesa [68.098150] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.568s) [68.103619] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [68.215104] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.118s) [68.220311] Starting dynamic subtest: drm_test_cmdline_res_rblank [68.339935] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.123s) [68.345107] Starting dynamic subtest: drm_test_cmdline_res_bpp [68.468943] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.129s) [68.474044] Starting dynamic subtest: drm_test_cmdline_res_refresh [68.568531] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.101s) [68.573593] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [68.688975] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.119s) [68.694142] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [68.824545] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.135s) [68.830466] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [68.938439] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.113s) [68.945452] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [69.067297] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.129s) [69.074229] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [69.177068] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.111s) [69.184080] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [69.271562] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.095s) [69.276680] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [69.369854] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.098s) [69.377088] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [69.462596] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.092s) [69.467828] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [69.554408] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.091s) [69.561593] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [69.680506] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.124s) [69.687705] Starting dynamic subtest: drm_test_cmdline_name [69.765107] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.086s) [69.772381] Starting dynamic subtest: drm_test_cmdline_name_bpp [69.902359] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.136s) [69.909398] Starting dynamic subtest: drm_test_cmdline_name_option [70.018250] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.115s) [70.025158] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [70.130229] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.112s) [70.137397] Starting dynamic subtest: drm_test_cmdline_rotate_0 [70.261271] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.131s) [70.268405] Starting dynamic subtest: drm_test_cmdline_rotate_90 [70.399708] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.138s) [70.404894] Starting dynamic subtest: drm_test_cmdline_rotate_180 [70.530307] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.130s) [70.537450] Starting dynamic subtest: drm_test_cmdline_rotate_270 [70.664398] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.134s) [70.671360] Starting dynamic subtest: drm_test_cmdline_hmirror [70.807452] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.143s) [70.814407] Starting dynamic subtest: drm_test_cmdline_vmirror [70.890531] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.084s) [70.895702] Starting dynamic subtest: drm_test_cmdline_margin_options [70.975947] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.086s) [70.981183] Starting dynamic subtest: drm_test_cmdline_multiple_options [71.112591] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.135s) [71.118268] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [71.239358] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.126s) [71.244763] Starting dynamic subtest: drm_test_cmdline_extra_and_option [71.358073] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.119s) [71.365166] Starting dynamic subtest: drm_test_cmdline_freestanding_options [71.479414] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.121s) [71.485081] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [71.606359] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.128s) [71.612458] Starting dynamic subtest: drm_test_cmdline_panel_orientation [71.728314] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.120s) [71.734078] Starting dynamic subtest: drm_test_cmdline_invalid [71.861368] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.134s) [71.866449] Starting dynamic subtest: drm_test_cmdline_tv_options [71.994310] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.133s) [71.995238] Subtest drm_cmdline_parser: SUCCESS (5.893s) [72.181209] [005/134] (946s left) gem_exec_suspend (basic-s0) [72.257965] Starting subtest: basic-S0 [72.259230] Starting dynamic subtest: smem [93.134485] Dynamic subtest smem: SUCCESS (7.637s) [93.135984] Subtest basic-S0: SUCCESS (7.638s) [99.332387] [006/134] (925s left) kms_content_protection (uevent) [99.490181] Starting subtest: uevent [99.492628] Subtest uevent: SKIP (0.000s) [99.643845] [007/134] (925s left) gem_eio (in-flight-suspend) [99.875062] Starting subtest: in-flight-suspend [142.803073] Subtest in-flight-suspend: SUCCESS (13.766s) [148.972665] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true [148.975365] [008/134] (881s left) gem_spin_batch (resubmit-all) [149.042590] Starting subtest: resubmit-all [149.043548] Starting dynamic subtest: rcs0 [149.059205] Dynamic subtest rcs0: SUCCESS (0.017s) [149.066337] Starting dynamic subtest: bcs0 [149.067267] Dynamic subtest bcs0: SUCCESS (0.005s) [149.076362] Starting dynamic subtest: vcs0 [149.077223] Dynamic subtest vcs0: SUCCESS (0.003s) [149.083328] Starting dynamic subtest: vcs1 [149.084152] Dynamic subtest vcs1: SUCCESS (0.002s) [149.090173] Starting dynamic subtest: vecs0 [149.091026] Dynamic subtest vecs0: SUCCESS (0.002s) [149.097145] Starting dynamic subtest: ccs0 [149.098017] Dynamic subtest ccs0: SUCCESS (0.003s) [149.098880] Subtest resubmit-all: SUCCESS (0.034s) [150.474412] [009/134] (880s left) kms_psr (psr-cursor-plane-onoff) [150.576622] Starting subtest: psr-cursor-plane-onoff [150.577633] Starting dynamic subtest: eDP-1 [152.293832] Dynamic subtest eDP-1: SUCCESS (1.722s) [152.294772] Subtest psr-cursor-plane-onoff: SUCCESS (1.723s) [153.170932] [010/134] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [153.278914] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [160.182577] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.921s) [160.344432] [011/134] (870s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [160.439736] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [160.441568] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [160.545130] [012/134] (870s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [165.544546] Starting subtest: fbc-psr2-cursor-plane-update-sf [165.545452] Starting dynamic subtest: pipe-A-eDP-1 [166.342143] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s) [166.349037] Starting dynamic subtest: pipe-B-eDP-1 [167.474383] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s) [167.476203] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.934s) [168.677815] [013/134] (862s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [173.654837] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [173.655754] Starting dynamic subtest: pipe-A-eDP-1 [180.302683] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.658s) [180.310622] Starting dynamic subtest: pipe-B-eDP-1 [186.941518] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.646s) [186.942385] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.308s) [187.806823] [014/134] (843s left) kms_pm_rpm (basic-pci-d3-state) [189.553961] Starting subtest: basic-pci-d3-state [191.046814] Subtest basic-pci-d3-state: SUCCESS (1.496s) [191.178327] [015/134] (839s left) gem_ctx_exec (basic-norecovery) [191.228804] Starting subtest: basic-norecovery [191.594391] Subtest basic-norecovery: SUCCESS (0.366s) [191.736009] [016/134] (839s left) gem_pxp (protected-encrypted-src-copy-not-readible) [191.865646] Starting subtest: protected-encrypted-src-copy-not-readible [191.980543] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.114s) [192.135866] [017/134] (839s left) kms_flip (absolute-wf_vblank) [192.239232] Starting subtest: absolute-wf_vblank [192.241364] Starting dynamic subtest: A-eDP1 [200.946154] Dynamic subtest A-eDP1: SUCCESS (8.715s) [200.957418] Starting dynamic subtest: B-eDP1 [209.669741] Dynamic subtest B-eDP1: SUCCESS (8.730s) [209.680544] Starting dynamic subtest: C-eDP1 [218.387089] Dynamic subtest C-eDP1: SUCCESS (8.723s) [218.396237] Starting dynamic subtest: D-eDP1 [227.115115] Dynamic subtest D-eDP1: SUCCESS (8.734s) [227.118931] Subtest absolute-wf_vblank: SUCCESS (34.913s) [228.332510] [018/134] (802s left) prime_mmap (test_refcounting) [228.401583] Starting subtest: test_refcounting [228.402582] Starting dynamic subtest: test_refcounting-smem [228.432082] Dynamic subtest test_refcounting-smem: SUCCESS (0.030s) [228.433084] Subtest test_refcounting: SUCCESS (0.031s) [228.549821] [019/134] (802s left) gem_exec_schedule (pi-common) [228.770114] Starting subtest: pi-common [228.771184] Starting dynamic subtest: rcs0 [228.799935] Dynamic subtest rcs0: SUCCESS (0.030s) [228.806961] Starting dynamic subtest: bcs0 [228.833050] Dynamic subtest bcs0: SUCCESS (0.033s) [228.840138] Starting dynamic subtest: vcs0 [228.862846] Dynamic subtest vcs0: SUCCESS (0.029s) [228.869912] Starting dynamic subtest: vcs1 [228.891353] Dynamic subtest vcs1: SUCCESS (0.028s) [228.901987] Starting dynamic subtest: vecs0 [228.916588] Dynamic subtest vecs0: SUCCESS (0.025s) [228.923316] Starting dynamic subtest: ccs0 [228.942391] Dynamic subtest ccs0: SUCCESS (0.025s) [228.943265] Subtest pi-common: SUCCESS (0.174s) [229.190111] [020/134] (802s left) perf (unprivileged-single-ctx-counters) [229.327778] Starting subtest: unprivileged-single-ctx-counters [229.329512] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [229.364466] [021/134] (801s left) api_intel_allocator (fork-simple-stress-signal) [229.428317] Starting subtest: fork-simple-stress-signal [234.829851] Subtest fork-simple-stress-signal: SUCCESS (5.402s) [234.963147] [022/134] (796s left) kms_flip (flip-vs-panning-vs-hang) [235.070020] Starting subtest: flip-vs-panning-vs-hang [235.071022] Starting dynamic subtest: A-eDP1 [285.951910] Dynamic subtest A-eDP1: SUCCESS (50.892s) [285.962009] Starting dynamic subtest: D-eDP1 [335.879513] Dynamic subtest D-eDP1: SUCCESS (49.892s) [335.882283] Subtest flip-vs-panning-vs-hang: SUCCESS (100.790s) [337.035612] [023/134] (694s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [342.023487] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [342.024507] Starting dynamic subtest: pipe-A-eDP-1 [354.034756] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.008s) [354.042161] Starting dynamic subtest: pipe-B-eDP-1 [366.066671] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.032s) [366.067623] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.044s) [366.924092] [024/134] (664s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [366.986506] Starting subtest: invalid-multi-wait-unsubmitted-submitted [366.987578] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s) [367.122921] [025/134] (664s left) gem_exec_create (basic) [367.188346] Starting subtest: basic [367.189473] Starting dynamic subtest: smem [370.394184] Dynamic subtest smem: SUCCESS (3.203s) [370.395567] Subtest basic: SUCCESS (3.205s) [370.585646] [026/134] (660s left) gem_ctx_persistence (smoketest) [370.661469] Starting subtest: smoketest [411.385634] Subtest smoketest: SUCCESS (40.724s) [411.473371] [027/134] (620s left) gem_ctx_bad_destroy (invalid-pad) [411.530275] Starting subtest: invalid-pad [411.531270] Subtest invalid-pad: SUCCESS (0.000s) [411.610544] [028/134] (619s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [411.718900] Starting subtest: cursorA-vs-flipB-legacy [411.720577] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [411.868879] [029/134] (619s left) kms_atomic_interruptible (legacy-setmode) [411.965100] Starting subtest: legacy-setmode [411.965984] Starting dynamic subtest: pipe-A-eDP-1 [418.869629] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.902s) [418.870547] Subtest legacy-setmode: SUCCESS (6.904s) [419.732917] [030/134] (611s left) kms_cdclk (mode-transition) [419.829113] Starting subtest: mode-transition [419.830083] Starting dynamic subtest: pipe-A-eDP-1 [420.113288] Dynamic subtest pipe-A-eDP-1: SKIP (0.284s) [420.120707] Starting dynamic subtest: pipe-B-eDP-1 [420.122533] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [420.129521] Starting dynamic subtest: pipe-C-eDP-1 [420.131328] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [420.138774] Starting dynamic subtest: pipe-D-eDP-1 [420.140574] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [420.142377] Subtest mode-transition: SKIP (0.292s) [420.967500] [031/134] (610s left) kms_big_fb (linear-8bpp-rotate-270) [421.064154] Starting subtest: linear-8bpp-rotate-270 [421.086249] Subtest linear-8bpp-rotate-270: SKIP (0.021s) [421.220840] [032/134] (610s left) perf_pmu (faulting-read) [421.254972] Starting subtest: faulting-read [421.255888] Starting dynamic subtest: wb [421.256780] Dynamic subtest wb: SUCCESS (0.001s) [421.264789] Starting dynamic subtest: wc [421.265818] Dynamic subtest wc: SUCCESS (0.000s) [421.274804] Starting dynamic subtest: uc [421.275608] Dynamic subtest uc: SUCCESS (0.000s) [421.276416] Subtest faulting-read: SUCCESS (0.003s) [421.384972] [033/134] (610s left) kms_psr (fbc-psr2-primary-render) [421.479293] Starting subtest: fbc-psr2-primary-render [421.480191] Starting dynamic subtest: eDP-1 [421.481984] Dynamic subtest eDP-1: SKIP (0.000s) [421.483819] Subtest fbc-psr2-primary-render: SKIP (0.001s) [421.561033] [034/134] (610s left) gem_exec_schedule (deep) [421.734405] Starting subtest: deep [421.735554] Starting dynamic subtest: rcs0 [426.921152] Dynamic subtest rcs0: SKIP (5.181s) [426.930787] Starting dynamic subtest: vcs0 [438.045141] Dynamic subtest vcs0: SUCCESS (11.123s) [438.055248] Starting dynamic subtest: vcs1 [449.838815] Dynamic subtest vcs1: SUCCESS (11.792s) [449.847653] Starting dynamic subtest: vecs0 [461.677755] Dynamic subtest vecs0: SUCCESS (11.836s) [461.688695] Starting dynamic subtest: ccs0 [475.439194] Dynamic subtest ccs0: SUCCESS (13.761s) [475.440597] Subtest deep: SUCCESS (53.698s) [476.645543] [035/134] (555s left) kms_selftest (drm_plane_helper) [476.680001] Starting subtest: drm_plane_helper [476.745814] Starting dynamic subtest: drm_test_check_plane_state [476.887609] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.143s) [476.901904] Starting dynamic subtest: drm_test_check_invalid_plane_state [477.030204] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.141s) [477.031239] Subtest drm_plane_helper: SUCCESS (0.352s) [477.247639] [036/134] (554s left) syncobj_basic (bad-pad-fd-to-handle) [477.294416] Starting subtest: bad-pad-fd-to-handle [477.295495] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [477.424026] [037/134] (554s left) gem_lmem_swapping (parallel-random-engines) [477.458017] Subtest parallel-random-engines: SKIP (0.000s) [477.494069] [038/134] (554s left) kms_mmap_write_crc (main) [477.587399] Starting subtest: main [477.588268] Starting dynamic subtest: pipe-A-eDP-1 [480.937840] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.348s) [480.938696] Subtest main: SUCCESS (3.349s) [481.795553] [039/134] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [481.893908] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [488.712469] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.823s) [488.867602] [040/134] (543s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [488.966373] Starting subtest: addfb25-yf-tiled-legacy [488.967260] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [489.091997] [041/134] (542s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [489.181125] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [489.182953] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [489.289413] [042/134] (542s left) gem_ctx_exec (basic) [489.349737] Starting subtest: basic [489.359235] Subtest basic: SUCCESS (0.010s) [489.510178] [043/134] (542s left) kms_atomic (test-only) [489.609143] Starting subtest: test-only [489.660910] Starting dynamic subtest: pipe-A-eDP-1 [492.136703] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.476s) [492.137643] Subtest test-only: SUCCESS (2.529s) [493.018130] [044/134] (539s left) gem_set_tiling_vs_gtt [493.151731] [045/134] (538s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [493.258457] Starting subtest: yf-tiled-16bpp-rotate-0 [493.260309] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [493.392581] [046/134] (538s left) kms_getfb (getfb2-handle-zero) [493.487243] Starting subtest: getfb2-handle-zero [493.488199] Subtest getfb2-handle-zero: SUCCESS (0.000s) [493.602001] [047/134] (538s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [493.658776] Starting subtest: single-wait-all-for-submit-available-submitted [493.659777] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [493.777326] [048/134] (538s left) gem_exec_reloc (basic-wc-cpu) [493.830676] Subtest basic-wc-cpu: SKIP (0.000s) [493.918100] [049/134] (538s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [493.999617] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [501.051166] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.053s) [501.203764] [050/134] (531s left) gem_basic (multigpu-create-close) [501.260592] Starting subtest: multigpu-create-close [501.262435] Subtest multigpu-create-close: SKIP (0.000s) [501.369665] [051/134] (530s left) kms_frontbuffer_tracking (fbc-suspend) [501.463005] Starting subtest: fbc-suspend [539.957749] Subtest fbc-suspend: SUCCESS (8.229s) [544.161475] [052/134] (491s left) gem_wait (wait) [544.232209] Starting subtest: wait [544.233601] Starting dynamic subtest: all-engines [545.683824] Dynamic subtest all-engines: SUCCESS (1.463s) [545.695139] Starting dynamic subtest: rcs0 [546.734378] Dynamic subtest rcs0: SUCCESS (1.060s) [546.744777] Starting dynamic subtest: bcs0 [547.784682] Dynamic subtest bcs0: SUCCESS (1.059s) [547.797462] Starting dynamic subtest: vcs0 [548.832932] Dynamic subtest vcs0: SUCCESS (1.054s) [548.845314] Starting dynamic subtest: vcs1 [549.880714] Dynamic subtest vcs1: SUCCESS (1.053s) [549.891644] Starting dynamic subtest: vecs0 [550.928932] Dynamic subtest vecs0: SUCCESS (1.053s) [550.941444] Starting dynamic subtest: ccs0 [551.978974] Dynamic subtest ccs0: SUCCESS (1.054s) [551.980599] Subtest wait: SUCCESS (7.810s) [552.176143] [053/134] (483s left) gem_exec_reloc (basic-wc-active) [552.228183] Subtest basic-wc-active: SKIP (0.000s) [552.303049] [054/134] (483s left) kms_pm_rpm (pc8-residency) [553.811742] Starting subtest: pc8-residency [553.814505] Subtest pc8-residency: SKIP (0.000s) [554.592468] [055/134] (480s left) kms_dsc (dsc-with-bpc-formats) [554.683319] Starting subtest: dsc-with-bpc-formats [554.731295] Subtest dsc-with-bpc-formats: SKIP (0.003s) [554.760958] [056/134] (480s left) kms_psr (pr-cursor-plane-move) [554.853428] Starting subtest: pr-cursor-plane-move [554.855699] Subtest pr-cursor-plane-move: SKIP (0.000s) [554.931354] [057/134] (480s left) kms_vblank (ts-continuation-dpms-suspend) [555.023815] Starting subtest: ts-continuation-dpms-suspend [555.024802] Starting dynamic subtest: pipe-A-eDP-1 [573.029013] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.241s) [573.038475] Starting dynamic subtest: pipe-D-eDP-1 [591.024556] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.855s) [591.025524] Subtest ts-continuation-dpms-suspend: SUCCESS (5.101s) [597.843551] [058/134] (443s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [597.920398] Starting subtest: multi-wait-available-unsubmitted-signaled [597.921740] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [598.017210] [059/134] (443s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [598.143325] Starting subtest: basic-flip-before-cursor-legacy [599.071493] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.933s) [599.945982] [060/134] (441s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [600.324571] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [601.120235] [061/134] (440s left) gem_exec_params (invalid-flag) [601.184110] Starting subtest: invalid-flag [601.185704] Subtest invalid-flag: SUCCESS (0.000s) [601.300898] [062/134] (440s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [601.400795] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [601.402850] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [601.498676] [063/134] (440s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [601.558624] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [601.559882] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [601.677364] [064/134] (440s left) prime_vgem (wait) [601.772652] Starting subtest: wait [601.774000] Starting dynamic subtest: rcs0 [601.829965] Dynamic subtest rcs0: SUCCESS (0.057s) [601.838250] Starting dynamic subtest: bcs0 [601.910227] Dynamic subtest bcs0: SUCCESS (0.080s) [601.917976] Starting dynamic subtest: vcs0 [601.958202] Dynamic subtest vcs0: SUCCESS (0.048s) [601.965797] Starting dynamic subtest: vcs1 [602.002963] Dynamic subtest vcs1: SUCCESS (0.044s) [602.010549] Starting dynamic subtest: vecs0 [602.052235] Dynamic subtest vecs0: SUCCESS (0.049s) [602.059847] Starting dynamic subtest: ccs0 [602.099715] Dynamic subtest ccs0: SUCCESS (0.047s) [602.100944] Subtest wait: SUCCESS (0.330s) [602.231318] [065/134] (439s left) gem_exec_capture (capture) [602.290201] Starting subtest: capture [602.291394] Starting dynamic subtest: rcs0-smem [603.128854] Dynamic subtest rcs0-smem: SUCCESS (0.844s) [603.136761] Starting dynamic subtest: bcs0-smem [604.457761] Dynamic subtest bcs0-smem: SUCCESS (1.336s) [604.466236] Starting dynamic subtest: vcs0-smem [605.274588] Dynamic subtest vcs0-smem: SUCCESS (0.822s) [605.282723] Starting dynamic subtest: vcs1-smem [606.596537] Dynamic subtest vcs1-smem: SUCCESS (1.328s) [606.604354] Starting dynamic subtest: vecs0-smem [607.450786] Dynamic subtest vecs0-smem: FAIL (0.832s) [607.458288] Starting dynamic subtest: ccs0-smem [608.750686] Dynamic subtest ccs0-smem: SUCCESS (1.328s) [608.751713] Subtest capture: FAIL (6.495s) [608.887258] [066/134] (432s left) kms_cursor_crc (cursor-rapid-movement-512x512) [609.162888] Starting subtest: cursor-rapid-movement-512x512 [609.165906] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [609.335507] [067/134] (432s left) kms_flip (2x-flip-vs-wf_vblank) [609.429728] Starting subtest: 2x-flip-vs-wf_vblank [609.441955] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s) [609.566767] [068/134] (432s left) i915_pm_freq_api (freq-suspend) [609.625828] Starting subtest: freq-suspend [609.627189] Starting dynamic subtest: gt0 [626.470587] Dynamic subtest gt0: SUCCESS (1.639s) [626.504614] Starting dynamic subtest: gt1 [643.469170] Dynamic subtest gt1: SUCCESS (1.602s) [643.470173] Subtest freq-suspend: SUCCESS (3.243s) [650.571166] [069/134] (398s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [650.684017] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [650.685727] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [650.815278] [070/134] (398s left) kms_chamelium_frames (hdmi-aspect-ratio) [651.193166] Subtest hdmi-aspect-ratio: SKIP (0.000s) [652.016049] [071/134] (396s left) kms_cursor_crc (cursor-sliding-max-size) [652.313418] Starting subtest: cursor-sliding-max-size [652.315986] Subtest cursor-sliding-max-size: SKIP (0.000s) [652.465950] [072/134] (396s left) kms_color_pipeline (plane-ctm3x4-lut1d) [652.555729] Starting subtest: plane-ctm3x4-lut1d [652.569644] Starting dynamic subtest: pipe-A-eDP-1 [653.052094] Dynamic subtest pipe-A-eDP-1: FAIL (0.338s) [653.995518] Starting dynamic subtest: pipe-B-eDP-1 [654.479020] Dynamic subtest pipe-B-eDP-1: FAIL (0.279s) [655.319984] Starting dynamic subtest: pipe-C-eDP-1 [655.765405] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s) [656.634676] Starting dynamic subtest: pipe-D-eDP-1 [657.099278] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s) [657.161508] Subtest plane-ctm3x4-lut1d: FAIL (4.640s) [658.004205] [073/134] (391s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [658.108393] Starting subtest: psr-1p-pri-indfb-multidraw [680.426754] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.359s) [680.524238] [074/134] (368s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [680.622623] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [680.624238] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [680.739887] [075/134] (368s left) syncobj_timeline (invalid-query-illegal-handle) [680.798146] Starting subtest: invalid-query-illegal-handle [680.798976] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [680.919115] [076/134] (368s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [681.013803] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [681.014765] Starting dynamic subtest: pipe-A-eDP-1 [683.051176] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.038s) [683.060180] Starting dynamic subtest: pipe-B-eDP-1 [685.151040] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.099s) [685.160100] Starting dynamic subtest: pipe-C-eDP-1 [687.228835] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.077s) [687.248653] Starting dynamic subtest: pipe-D-eDP-1 [689.257602] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.028s) [689.258461] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.247s) [690.508804] [077/134] (358s left) kms_addfb_basic (too-high) [690.605283] Starting subtest: too-high [690.606123] Subtest too-high: SUCCESS (0.000s) [690.723163] [078/134] (358s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [690.815954] Starting subtest: psr-rgb565-draw-mmap-gtt [690.817779] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [690.942743] [079/134] (358s left) gem_mmap_offset (mmap-unmap) [690.992132] Starting subtest: mmap-unmap [690.993399] Starting dynamic subtest: smem0 [714.091646] Dynamic subtest smem0: SUCCESS (23.107s) [714.093104] Subtest mmap-unmap: SUCCESS (23.108s) [714.237729] [080/134] (335s left) gem_pread (exhaustion) [714.286379] Subtest exhaustion: SKIP (0.000s) [714.334393] [081/134] (334s left) kms_joiner (invalid-modeset-ultra-joiner) [714.432180] Starting subtest: invalid-modeset-ultra-joiner [714.434011] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [714.508758] [082/134] (334s left) i915_drm_fdinfo (basics) [714.547749] Starting subtest: basics [714.548652] Subtest basics: SUCCESS (0.000s) [714.621258] [083/134] (334s left) gem_ccs (ctrl-surf-copy-new-ctx) [714.682255] Starting subtest: ctrl-surf-copy-new-ctx [714.684236] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [714.799873] [084/134] (334s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [714.889806] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [714.917272] Starting dynamic subtest: pipe-A-plane-0 [715.527582] Dynamic subtest pipe-A-plane-0: SUCCESS (0.611s) [715.537513] Starting dynamic subtest: pipe-A-plane-3 [715.949708] Dynamic subtest pipe-A-plane-3: SUCCESS (0.420s) [715.957451] Starting dynamic subtest: pipe-A-plane-5 [715.959070] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [717.074116] Starting dynamic subtest: pipe-B-plane-0 [717.700380] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s) [717.708208] Starting dynamic subtest: pipe-B-plane-3 [718.111219] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s) [718.119173] Starting dynamic subtest: pipe-B-plane-5 [718.120793] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [718.426540] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.538s) [719.254461] [085/134] (330s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [719.354184] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [719.355832] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [719.451904] [086/134] (329s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [719.537844] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [719.538835] Starting dynamic subtest: pipe-A-default-mode [720.709412] Dynamic subtest pipe-A-default-mode: SKIP (1.171s) [720.711041] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.172s) [720.874882] [087/134] (328s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [720.982565] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [720.984171] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [721.080715] [088/134] (328s left) kms_draw_crc (fill-fb) [721.178665] Starting subtest: fill-fb [721.598715] Subtest fill-fb: SUCCESS (0.420s) [721.720881] [089/134] (327s left) kms_big_fb (y-tiled-8bpp-rotate-0) [721.827483] Starting subtest: y-tiled-8bpp-rotate-0 [721.829307] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [721.931434] [090/134] (327s left) gem_render_copy (yf-tiled-to-vebox-linear) [721.981392] Starting subtest: yf-tiled-to-vebox-linear [721.983413] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [722.168322] [091/134] (327s left) syncobj_wait (invalid-reset-illegal-handle) [722.224189] Starting subtest: invalid-reset-illegal-handle [722.225222] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [722.339893] [092/134] (327s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [722.450067] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [729.431683] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.983s) [729.596288] [093/134] (320s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [729.697269] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [729.698973] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [729.800561] [094/134] (319s left) api_intel_bb (full-batch) [729.851476] Starting subtest: full-batch [729.856803] Subtest full-batch: SUCCESS (0.006s) [730.000355] [095/134] (319s left) kms_psr (fbc-psr-basic) [730.090940] Starting subtest: fbc-psr-basic [730.091717] Starting dynamic subtest: eDP-1 [730.093380] Dynamic subtest eDP-1: SKIP (0.000s) [730.094974] Subtest fbc-psr-basic: SKIP (0.001s) [730.179324] [096/134] (319s left) gem_exercise_blt (fast-copy-emit) [730.241398] Starting subtest: fast-copy-emit [730.242405] Starting dynamic subtest: linear-smem-smem-emit [730.263797] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [730.275425] Starting dynamic subtest: xmajor-smem-smem-emit [730.280963] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [730.288424] Starting dynamic subtest: tile4-smem-smem-emit [730.297945] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s) [730.305191] Starting dynamic subtest: tile64-smem-smem-emit [730.314674] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s) [730.315618] Subtest fast-copy-emit: SUCCESS (0.074s) [730.477093] [097/134] (319s left) sysfs_heartbeat_interval (mixed) [730.538912] Starting subtest: mixed [730.539827] Starting dynamic subtest: vecs0 [735.801240] Dynamic subtest vecs0: SUCCESS (5.265s) [735.812408] Starting dynamic subtest: ccs0 [740.999415] Dynamic subtest ccs0: SUCCESS (5.197s) [741.011834] Starting dynamic subtest: vcs0 [746.253265] Dynamic subtest vcs0: SUCCESS (5.248s) [746.264901] Starting dynamic subtest: bcs0 [751.463105] Dynamic subtest bcs0: SUCCESS (5.205s) [751.474822] Starting dynamic subtest: rcs0 [756.671084] Dynamic subtest rcs0: SUCCESS (5.204s) [756.684078] Starting dynamic subtest: vcs1 [761.944474] Dynamic subtest vcs1: SUCCESS (5.270s) [761.945826] Subtest mixed: SUCCESS (31.404s) [762.025156] [098/134] (287s left) kms_cursor_legacy (cursor-vs-flip-legacy) [762.152317] Starting subtest: cursor-vs-flip-legacy [791.486462] Subtest cursor-vs-flip-legacy: SUCCESS (29.333s) [792.329304] [099/134] (257s left) gem_exec_schedule (semaphore-resolve) [792.395109] Starting subtest: semaphore-resolve [792.431989] Subtest semaphore-resolve: SUCCESS (0.037s) [792.796663] [100/134] (257s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [792.897182] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [792.899068] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [793.016340] [101/134] (256s left) kms_cursor_legacy (torture-bo) [793.134498] Starting subtest: torture-bo [793.135387] Starting dynamic subtest: pipe-A [799.324503] Dynamic subtest pipe-A: SUCCESS (6.187s) [799.344033] Starting dynamic subtest: pipe-B [805.768105] Dynamic subtest pipe-B: SUCCESS (6.445s) [805.779998] Starting dynamic subtest: pipe-C [812.521648] Dynamic subtest pipe-C: SUCCESS (6.752s) [812.531246] Starting dynamic subtest: pipe-D [819.472897] Dynamic subtest pipe-D: SUCCESS (6.951s) [819.483034] Starting dynamic subtest: all-pipes [827.365465] Dynamic subtest all-pipes: SUCCESS (7.893s) [827.366644] Subtest torture-bo: SUCCESS (34.238s) [827.536310] [102/134] (222s left) gem_ctx_shared (q-independent) [827.605658] Starting subtest: Q-independent [827.606714] Starting dynamic subtest: rcs0 [827.676118] Dynamic subtest rcs0: SUCCESS (0.069s) [827.684381] Starting dynamic subtest: vcs0 [827.718491] Dynamic subtest vcs0: SUCCESS (0.042s) [827.727570] Starting dynamic subtest: vcs1 [827.759182] Dynamic subtest vcs1: SUCCESS (0.040s) [827.770381] Starting dynamic subtest: vecs0 [827.800051] Dynamic subtest vecs0: SUCCESS (0.037s) [827.808541] Starting dynamic subtest: ccs0 [827.849283] Dynamic subtest ccs0: SUCCESS (0.048s) [827.850566] Subtest Q-independent: SUCCESS (0.244s) [829.405727] [103/134] (220s left) gem_exec_fence (syncobj-timeline-invalid-wait) [829.963265] Starting subtest: syncobj-timeline-invalid-wait [829.968281] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s) [831.336035] [104/134] (218s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [831.392890] Starting subtest: y-tiled-ccs-to-x-tiled [831.394887] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [831.589497] [105/134] (218s left) drm_read (short-buffer-wakeup) [831.731094] Starting subtest: short-buffer-wakeup [863.939589] Subtest short-buffer-wakeup: SUCCESS (32.215s) [864.105091] [106/134] (186s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [864.193018] Starting subtest: plane-use-after-nonblocking-unbind-fencing [864.193907] Starting dynamic subtest: pipe-A-eDP-1 [864.258597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s) [864.564853] Starting dynamic subtest: pipe-B-eDP-1 [865.400319] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.844s) [865.690167] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.492s) [866.567948] [107/134] (183s left) syncobj_timeline (device-submit-unordered) [866.619827] Starting subtest: device-submit-unordered [866.620784] Subtest device-submit-unordered: SUCCESS (0.000s) [866.742086] [108/134] (183s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [866.843759] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [866.844657] Starting dynamic subtest: pipe-A-eDP-1 [867.092195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.237s) [867.100852] Starting dynamic subtest: pipe-B-eDP-1 [868.304498] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s) [868.312562] Starting dynamic subtest: pipe-C-eDP-1 [869.514150] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.208s) [869.522403] Starting dynamic subtest: pipe-D-eDP-1 [870.754945] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s) [870.755796] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.900s) [872.005622] [109/134] (178s left) kms_pipe_crc_basic (nonblocking-crc) [872.105319] Starting subtest: nonblocking-crc [872.106240] Starting dynamic subtest: pipe-A-eDP-1 [872.853311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s) [872.861391] Starting dynamic subtest: pipe-B-eDP-1 [874.284436] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.430s) [874.295267] Starting dynamic subtest: pipe-C-eDP-1 [875.697128] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.410s) [875.705395] Starting dynamic subtest: pipe-D-eDP-1 [877.030525] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [877.031310] Subtest nonblocking-crc: SUCCESS (4.924s) [877.836586] [110/134] (172s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [877.934609] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [877.936286] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [878.047953] [111/134] (172s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [878.147819] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [878.149645] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [878.284646] [112/134] (172s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [878.365797] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [878.393400] Starting dynamic subtest: pipe-A-plane-0 [878.395183] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [878.403216] Starting dynamic subtest: pipe-A-plane-3 [878.404978] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [878.415191] Starting dynamic subtest: pipe-A-plane-5 [878.417241] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [879.514227] Starting dynamic subtest: pipe-B-plane-0 [879.515972] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [879.523771] Starting dynamic subtest: pipe-B-plane-3 [879.525553] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [879.533131] Starting dynamic subtest: pipe-B-plane-5 [879.534971] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [879.823512] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (1.455s) [880.686912] [113/134] (169s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [880.776742] Starting subtest: plane-downscale-factor-0-5-with-rotation [880.777706] Starting dynamic subtest: pipe-A [880.792817] Dynamic subtest pipe-A: SKIP (0.015s) [880.800899] Starting dynamic subtest: pipe-B [880.821496] Dynamic subtest pipe-B: SKIP (0.028s) [880.829684] Starting dynamic subtest: pipe-C [880.849949] Dynamic subtest pipe-C: SKIP (0.028s) [880.857670] Starting dynamic subtest: pipe-D [880.878219] Dynamic subtest pipe-D: SKIP (0.027s) [880.879960] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.101s) [880.996168] [114/134] (169s left) perf_pmu (busy-hang) [881.039416] Starting subtest: busy-hang [881.040515] Starting dynamic subtest: rcs0 [882.359741] Dynamic subtest rcs0: SUCCESS (1.317s) [882.368764] Starting dynamic subtest: bcs0 [883.599158] Dynamic subtest bcs0: SUCCESS (1.238s) [883.610490] Starting dynamic subtest: vcs0 [885.743081] Dynamic subtest vcs0: SUCCESS (2.139s) [885.752290] Starting dynamic subtest: vcs1 [887.728259] Dynamic subtest vcs1: SUCCESS (1.983s) [887.737076] Starting dynamic subtest: vecs0 [889.704991] Dynamic subtest vecs0: SUCCESS (1.974s) [889.714396] Starting dynamic subtest: ccs0 [890.965528] Dynamic subtest ccs0: SUCCESS (1.259s) [890.966578] Subtest busy-hang: SUCCESS (9.922s) [891.078226] [115/134] (159s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [891.165797] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [891.166756] Starting dynamic subtest: pipe-A-eDP-1 [892.015015] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.846s) [892.022989] Starting dynamic subtest: pipe-B-eDP-1 [893.485441] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.469s) [893.493294] Starting dynamic subtest: pipe-C-eDP-1 [894.996130] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.509s) [895.004296] Starting dynamic subtest: pipe-D-eDP-1 [896.438530] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.441s) [896.439341] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.270s) [897.628284] [116/134] (152s left) kms_cursor_crc (cursor-offscreen-128x42) [897.848628] Starting subtest: cursor-offscreen-128x42 [897.889157] Subtest cursor-offscreen-128x42: SKIP (0.038s) [898.121876] [117/134] (152s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [898.209823] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [898.210826] Starting dynamic subtest: pipe-A [898.228233] Dynamic subtest pipe-A: SKIP (0.017s) [898.236450] Starting dynamic subtest: pipe-B [898.258136] Dynamic subtest pipe-B: SKIP (0.029s) [898.266204] Starting dynamic subtest: pipe-C [898.287540] Dynamic subtest pipe-C: SKIP (0.029s) [898.306427] Starting dynamic subtest: pipe-D [898.317573] Dynamic subtest pipe-D: SKIP (0.029s) [898.319146] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.107s) [898.442518] [118/134] (152s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [898.541309] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [899.520974] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.980s) [899.661075] [119/134] (150s left) syncobj_basic (bad-pad-handle-to-fd) [899.713548] Starting subtest: bad-pad-handle-to-fd [899.714707] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [899.826845] [120/134] (150s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [899.937853] Starting subtest: cursorA-vs-flipB-atomic-transitions [899.939690] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [900.091340] [121/134] (150s left) kms_frontbuffer_tracking (psr-2p-rte) [900.182343] Starting subtest: psr-2p-rte [900.184488] Subtest psr-2p-rte: SKIP (0.000s) [900.303290] [122/134] (150s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [900.407891] Starting subtest: psr-shrfb-scaledprimary [906.204251] Subtest psr-shrfb-scaledprimary: SUCCESS (5.796s) [906.338047] [123/134] (144s left) gen7_exec_parse (cmd-crossing-page) [906.387704] Subtest cmd-crossing-page: SKIP (0.000s) [906.457237] [124/134] (144s left) kms_frontbuffer_tracking (fbc-1p-rte) [906.556907] Starting subtest: fbc-1p-rte [912.052187] Subtest fbc-1p-rte: SUCCESS (5.495s) [913.260593] [125/134] (137s left) gem_mmap_wc (write) [913.314307] Subtest write: SKIP (0.000s) [913.380720] [126/134] (137s left) kms_busy (extended-modeset-hang-newfb) [913.461408] Starting subtest: extended-modeset-hang-newfb [913.462266] Starting dynamic subtest: pipe-A [948.197359] Dynamic subtest pipe-A: SUCCESS (34.733s) [948.211618] Starting dynamic subtest: pipe-D [971.148390] Dynamic subtest pipe-D: SUCCESS (22.949s) [971.149390] Subtest extended-modeset-hang-newfb: SUCCESS (57.687s) [971.945752] [127/134] ( 78s left) i915_pm_rpm (gem-evict-pwrite) [973.471740] Starting subtest: gem-evict-pwrite [973.473949] Subtest gem-evict-pwrite: SKIP (0.000s) [974.181343] [128/134] ( 76s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [974.279709] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [974.280587] Starting dynamic subtest: pipe-A-eDP-1 [974.289038] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [974.297629] Starting dynamic subtest: pipe-B-eDP-1 [974.306181] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [974.314496] Starting dynamic subtest: pipe-C-eDP-1 [974.322795] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [974.330866] Starting dynamic subtest: pipe-D-eDP-1 [974.339424] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [974.341068] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [976.452065] [129/134] ( 74s left) i915_suspend (basic-s2idle-without-i915) [976.481809] Starting subtest: basic-s2idle-without-i915 [997.832906] Subtest basic-s2idle-without-i915: SUCCESS (6.042s) [1002.942855] [130/134] ( 52s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [1003.047790] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [1003.048653] Starting dynamic subtest: pipe-A-default-mode [1005.804816] Dynamic subtest pipe-A-default-mode: SUCCESS (2.749s) [1005.805841] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.751s) [1006.640593] [131/134] ( 49s left) kms_big_fb (4-tiled-addfb) [1006.740331] Starting subtest: 4-tiled-addfb [1006.741207] Subtest 4-tiled-addfb: SUCCESS (0.000s) [1006.858537] [132/134] ( 49s left) kms_setmode (basic-clone-single-crtc) [1006.915404] Starting subtest: basic-clone-single-crtc [1006.918103] Subtest basic-clone-single-crtc: SKIP (0.000s) [1007.049905] [133/134] ( 48s left) gem_exec_balancer (full-late-pulse) [1007.102956] Starting subtest: full-late-pulse [1011.324200] Subtest full-late-pulse: SUCCESS (4.215s) [1011.667889] [134/134] ( 44s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [1011.770715] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [1011.772453] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [1011.866719] 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.