[57.504718] Initializing watchdogs [57.504764] /dev/watchdog0 [57.518580] [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] [57.522750] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.524869] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.528254] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [57.658140] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [64.960022] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.271s) [65.137142] [002/134] (952s left) gem_exec_params (secure-non-master) [65.204074] Starting subtest: secure-non-master [65.208251] Subtest secure-non-master: SKIP (0.000s) [65.320958] [003/134] (952s left) tools_test (tools_test) [65.366325] Starting subtest: tools_test [65.423793] Subtest tools_test: SUCCESS (0.071s) [65.508629] [004/134] (952s left) kms_selftest (drm_cmdline_parser) [65.545809] Starting subtest: drm_cmdline_parser [65.558830] Starting dynamic subtest: drm_test_cmdline_force_d_only [65.670223] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.112s) [65.679192] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [65.799280] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.127s) [65.807957] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [65.930150] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.130s) [65.936814] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [66.065337] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.134s) [66.074022] Starting dynamic subtest: drm_test_cmdline_force_e_only [66.171386] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.106s) [66.179481] Starting dynamic subtest: drm_test_cmdline_res [66.310049] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.138s) [66.316659] Starting dynamic subtest: drm_test_cmdline_res_vesa [66.449147] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.138s) [66.457905] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [66.576223] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.127s) [66.585001] Starting dynamic subtest: drm_test_cmdline_res_rblank [66.789436] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.213s) [66.798240] Starting dynamic subtest: drm_test_cmdline_res_bpp [67.312482] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.520s) [67.321514] Starting dynamic subtest: drm_test_cmdline_res_refresh [67.797565] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.485s) [67.806115] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [68.090524] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.292s) [68.099218] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [68.241309] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.150s) [68.249968] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [68.373282] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.131s) [68.382169] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [68.511279] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.138s) [68.519949] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [68.666504] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.154s) [68.675175] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [68.796269] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.129s) [68.804730] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [68.925564] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.128s) [68.934407] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [69.086227] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.160s) [69.094377] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [69.212278] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.125s) [69.220730] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [69.345380] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.132s) [69.354143] Starting dynamic subtest: drm_test_cmdline_name [69.487255] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.142s) [69.495283] Starting dynamic subtest: drm_test_cmdline_name_bpp [69.617533] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.129s) [69.624821] Starting dynamic subtest: drm_test_cmdline_name_option [69.750400] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.133s) [69.757549] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [69.885404] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.134s) [69.894149] Starting dynamic subtest: drm_test_cmdline_rotate_0 [70.034484] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.148s) [70.042970] Starting dynamic subtest: drm_test_cmdline_rotate_90 [70.176537] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.142s) [70.185095] Starting dynamic subtest: drm_test_cmdline_rotate_180 [70.338252] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.161s) [70.347066] Starting dynamic subtest: drm_test_cmdline_rotate_270 [70.483268] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.145s) [70.491189] Starting dynamic subtest: drm_test_cmdline_hmirror [70.650613] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.167s) [70.657458] Starting dynamic subtest: drm_test_cmdline_vmirror [70.795676] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.144s) [70.803221] Starting dynamic subtest: drm_test_cmdline_margin_options [70.936232] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.140s) [70.944500] Starting dynamic subtest: drm_test_cmdline_multiple_options [71.047262] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.111s) [71.055791] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [71.196212] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.147s) [71.203098] Starting dynamic subtest: drm_test_cmdline_extra_and_option [71.330197] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.134s) [71.336592] Starting dynamic subtest: drm_test_cmdline_freestanding_options [71.460177] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.129s) [71.469408] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [71.548556] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.089s) [71.557289] Starting dynamic subtest: drm_test_cmdline_panel_orientation [71.664844] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.115s) [71.673294] Starting dynamic subtest: drm_test_cmdline_invalid [71.790153] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.125s) [71.796824] Starting dynamic subtest: drm_test_cmdline_tv_options [71.912827] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.123s) [71.915037] Subtest drm_cmdline_parser: SUCCESS (6.355s) [72.101315] [005/134] (946s left) gem_exec_suspend (basic-s0) [72.166706] Starting subtest: basic-S0 [72.169064] Starting dynamic subtest: smem [91.860969] Dynamic subtest smem: SUCCESS (6.657s) [91.863869] Subtest basic-S0: SUCCESS (6.658s) [92.052139] [006/134] (926s left) kms_content_protection (uevent) [92.226676] Starting subtest: uevent [92.231546] Subtest uevent: SKIP (0.000s) [92.363805] [007/134] (925s left) gem_eio (in-flight-suspend) [92.613692] Starting subtest: in-flight-suspend [135.364416] Subtest in-flight-suspend: SUCCESS (13.152s) [135.528654] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true [135.531776] [008/134] (882s left) gem_spin_batch (resubmit-all) [135.601487] Starting subtest: resubmit-all [135.603739] Starting dynamic subtest: rcs0 [135.613206] Dynamic subtest rcs0: SUCCESS (0.011s) [135.622831] Starting dynamic subtest: bcs0 [135.625083] Dynamic subtest bcs0: SUCCESS (0.002s) [135.632930] Starting dynamic subtest: vcs0 [135.634834] Dynamic subtest vcs0: SUCCESS (0.002s) [135.642349] Starting dynamic subtest: vcs1 [135.644190] Dynamic subtest vcs1: SUCCESS (0.002s) [135.651608] Starting dynamic subtest: vecs0 [135.653483] Dynamic subtest vecs0: SUCCESS (0.002s) [135.661031] Starting dynamic subtest: ccs0 [135.662911] Dynamic subtest ccs0: SUCCESS (0.002s) [135.664778] Subtest resubmit-all: SUCCESS (0.022s) [137.343404] [009/134] (880s left) kms_psr (psr-cursor-plane-onoff) [137.434972] Starting subtest: psr-cursor-plane-onoff [137.437268] Starting dynamic subtest: eDP-1 [139.126678] Dynamic subtest eDP-1: SUCCESS (1.686s) [139.129067] Subtest psr-cursor-plane-onoff: SUCCESS (1.687s) [140.020011] [010/134] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [140.122344] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [147.073304] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.820s) [147.250608] [011/134] (871s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [147.354904] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [147.359265] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [147.479112] [012/134] (870s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [152.513367] Starting subtest: fbc-psr2-cursor-plane-update-sf [152.515771] Starting dynamic subtest: pipe-A-eDP-1 [153.307561] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s) [153.317187] Starting dynamic subtest: pipe-B-eDP-1 [154.441057] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s) [154.446425] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.916s) [155.640924] [013/134] (862s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [160.736059] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [160.738396] Starting dynamic subtest: pipe-A-eDP-1 [167.359437] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.611s) [167.369592] Starting dynamic subtest: pipe-B-eDP-1 [174.051105] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.686s) [174.053486] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.301s) [174.933267] [014/134] (843s left) kms_pm_rpm (basic-pci-d3-state) [176.503614] Starting subtest: basic-pci-d3-state [177.970300] Subtest basic-pci-d3-state: SUCCESS (1.470s) [178.085470] [015/134] (840s left) gem_ctx_exec (basic-norecovery) [178.152909] Starting subtest: basic-norecovery [178.507106] Subtest basic-norecovery: SUCCESS (0.353s) [178.650920] [016/134] (839s left) gem_pxp (protected-encrypted-src-copy-not-readible) [178.773101] Starting subtest: protected-encrypted-src-copy-not-readible [178.891729] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.120s) [179.023319] [017/134] (839s left) kms_flip (absolute-wf_vblank) [179.111934] Starting subtest: absolute-wf_vblank [179.114086] Starting dynamic subtest: A-eDP1 [187.883832] Dynamic subtest A-eDP1: SUCCESS (8.774s) [187.894564] Starting dynamic subtest: B-eDP1 [196.616409] Dynamic subtest B-eDP1: SUCCESS (8.731s) [196.626329] Starting dynamic subtest: C-eDP1 [205.336325] Dynamic subtest C-eDP1: SUCCESS (8.717s) [205.345404] Starting dynamic subtest: D-eDP1 [214.062426] Dynamic subtest D-eDP1: SUCCESS (8.723s) [214.067294] Subtest absolute-wf_vblank: SUCCESS (34.955s) [215.287487] [018/134] (803s left) prime_mmap (test_refcounting) [215.345809] Starting subtest: test_refcounting [215.348144] Starting dynamic subtest: test_refcounting-smem [215.372721] Dynamic subtest test_refcounting-smem: SUCCESS (0.029s) [215.375198] Subtest test_refcounting: SUCCESS (0.029s) [215.502423] [019/134] (803s left) gem_exec_schedule (pi-common) [215.691592] Starting subtest: pi-common [215.694077] Starting dynamic subtest: rcs0 [215.717988] Dynamic subtest rcs0: SUCCESS (0.030s) [215.728057] Starting dynamic subtest: bcs0 [215.750196] Dynamic subtest bcs0: SUCCESS (0.031s) [215.762068] Starting dynamic subtest: vcs0 [215.778200] Dynamic subtest vcs0: SUCCESS (0.027s) [215.790031] Starting dynamic subtest: vcs1 [215.806225] Dynamic subtest vcs1: SUCCESS (0.027s) [215.817099] Starting dynamic subtest: vecs0 [215.833610] Dynamic subtest vecs0: SUCCESS (0.027s) [215.845199] Starting dynamic subtest: ccs0 [215.861719] Dynamic subtest ccs0: SUCCESS (0.027s) [215.863926] Subtest pi-common: SUCCESS (0.174s) [216.147618] [020/134] (802s left) perf (unprivileged-single-ctx-counters) [216.286344] Starting subtest: unprivileged-single-ctx-counters [216.290596] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [216.327830] [021/134] (802s left) api_intel_allocator (fork-simple-stress-signal) [216.382094] Starting subtest: fork-simple-stress-signal [221.784420] Subtest fork-simple-stress-signal: SUCCESS (5.401s) [221.936869] [022/134] (796s left) kms_flip (flip-vs-panning-vs-hang) [222.044247] Starting subtest: flip-vs-panning-vs-hang [222.046616] Starting dynamic subtest: A-eDP1 [272.825860] Dynamic subtest A-eDP1: SUCCESS (50.779s) [272.836284] Starting dynamic subtest: D-eDP1 [322.805958] Dynamic subtest D-eDP1: SUCCESS (49.967s) [322.808469] Subtest flip-vs-panning-vs-hang: SUCCESS (100.751s) [323.990411] [023/134] (694s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [328.961130] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [328.963352] Starting dynamic subtest: pipe-A-eDP-1 [341.020890] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.053s) [341.030724] Starting dynamic subtest: pipe-B-eDP-1 [353.029433] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.004s) [353.031790] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.061s) [353.895277] [024/134] (665s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [353.975015] Starting subtest: invalid-multi-wait-unsubmitted-submitted [353.977384] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [354.080314] [025/134] (664s left) gem_exec_create (basic) [354.145834] Starting subtest: basic [354.148289] Starting dynamic subtest: smem [357.259900] Dynamic subtest smem: SUCCESS (3.112s) [357.262492] Subtest basic: SUCCESS (3.114s) [357.477206] [026/134] (661s left) gem_ctx_persistence (smoketest) [357.538606] Starting subtest: smoketest [398.250501] Subtest smoketest: SUCCESS (40.716s) [398.336630] [027/134] (620s left) gem_ctx_bad_destroy (invalid-pad) [398.398528] Starting subtest: invalid-pad [398.400907] Subtest invalid-pad: SUCCESS (0.000s) [398.491351] [028/134] (620s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [398.625519] Starting subtest: cursorA-vs-flipB-legacy [398.629826] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [398.793458] [029/134] (620s left) kms_atomic_interruptible (legacy-setmode) [398.897927] Starting subtest: legacy-setmode [398.900136] Starting dynamic subtest: pipe-A-eDP-1 [405.802544] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.904s) [405.804856] Subtest legacy-setmode: SUCCESS (6.906s) [406.676272] [030/134] (612s left) kms_cdclk (mode-transition) [406.774905] Starting subtest: mode-transition [406.777185] Starting dynamic subtest: pipe-A-eDP-1 [407.070628] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s) [407.081064] Starting dynamic subtest: pipe-B-eDP-1 [407.085404] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [407.097274] Starting dynamic subtest: pipe-C-eDP-1 [407.102072] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [407.110559] Starting dynamic subtest: pipe-D-eDP-1 [407.114537] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [407.118557] Subtest mode-transition: SKIP (0.301s) [407.905479] [031/134] (611s left) kms_big_fb (linear-8bpp-rotate-270) [408.014176] Starting subtest: linear-8bpp-rotate-270 [408.034495] Subtest linear-8bpp-rotate-270: SKIP (0.019s) [408.160231] [032/134] (611s left) perf_pmu (faulting-read) [408.204803] Starting subtest: faulting-read [408.207085] Starting dynamic subtest: wb [408.208910] Dynamic subtest wb: SUCCESS (0.001s) [408.217394] Starting dynamic subtest: wc [408.219309] Dynamic subtest wc: SUCCESS (0.000s) [408.227430] Starting dynamic subtest: uc [408.229375] Dynamic subtest uc: SUCCESS (0.000s) [408.231349] Subtest faulting-read: SUCCESS (0.003s) [408.343153] [033/134] (611s left) kms_psr (fbc-psr2-primary-render) [408.438975] Starting subtest: fbc-psr2-primary-render [408.441333] Starting dynamic subtest: eDP-1 [408.445820] Dynamic subtest eDP-1: SKIP (0.000s) [408.450287] Subtest fbc-psr2-primary-render: SKIP (0.001s) [408.533081] [034/134] (610s left) gem_exec_schedule (deep) [408.714790] Starting subtest: deep [408.717336] Starting dynamic subtest: rcs0 [413.851112] Dynamic subtest rcs0: SKIP (5.132s) [413.862752] Starting dynamic subtest: vcs0 [424.770051] Dynamic subtest vcs0: SUCCESS (10.920s) [424.780354] Starting dynamic subtest: vcs1 [436.187300] Dynamic subtest vcs1: SUCCESS (11.416s) [436.201230] Starting dynamic subtest: vecs0 [448.317096] Dynamic subtest vecs0: SUCCESS (12.127s) [448.331537] Starting dynamic subtest: ccs0 [460.694286] Dynamic subtest ccs0: SUCCESS (12.352s) [460.698683] Subtest deep: SUCCESS (51.953s) [462.581855] [035/134] (556s left) kms_selftest (drm_plane_helper) [462.615283] Starting subtest: drm_plane_helper [462.683263] Starting dynamic subtest: drm_test_check_plane_state [462.841828] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.159s) [462.850474] Starting dynamic subtest: drm_test_check_invalid_plane_state [462.996331] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.154s) [462.998187] Subtest drm_plane_helper: SUCCESS (0.381s) [463.211995] [036/134] (556s left) syncobj_basic (bad-pad-fd-to-handle) [463.268694] Starting subtest: bad-pad-fd-to-handle [463.271254] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [463.401666] [037/134] (556s left) gem_lmem_swapping (parallel-random-engines) [463.442828] Subtest parallel-random-engines: SKIP (0.000s) [463.484233] [038/134] (556s left) kms_mmap_write_crc (main) [463.581950] Starting subtest: main [463.584240] Starting dynamic subtest: pipe-A-eDP-1 [467.285692] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.700s) [467.287931] Subtest main: SUCCESS (3.701s) [468.126466] [039/134] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [468.245134] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [475.127001] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.885s) [475.297765] [040/134] (544s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [475.394656] Starting subtest: addfb25-yf-tiled-legacy [475.396796] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [475.525802] [041/134] (544s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [475.629553] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [475.633978] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [475.750504] [042/134] (543s left) gem_ctx_exec (basic) [475.809110] Starting subtest: basic [475.811683] Subtest basic: SUCCESS (0.005s) [475.970962] [043/134] (543s left) kms_atomic (test-only) [476.051024] Starting subtest: test-only [476.102708] Starting dynamic subtest: pipe-A-eDP-1 [478.632120] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.531s) [478.634468] Subtest test-only: SUCCESS (2.582s) [479.521077] [044/134] (540s left) gem_set_tiling_vs_gtt [479.662227] [045/134] (540s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [479.761371] Starting subtest: yf-tiled-16bpp-rotate-0 [479.765481] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [479.888081] [046/134] (540s left) kms_getfb (getfb2-handle-zero) [480.011982] Starting subtest: getfb2-handle-zero [480.014279] Subtest getfb2-handle-zero: SUCCESS (0.000s) [480.177363] [047/134] (539s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [480.231703] Starting subtest: single-wait-all-for-submit-available-submitted [480.233907] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [480.364166] [048/134] (539s left) gem_exec_reloc (basic-wc-cpu) [480.439418] Subtest basic-wc-cpu: SKIP (0.000s) [480.516709] [049/134] (539s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [480.622267] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [487.746508] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.124s) [487.914258] [050/134] (532s left) gem_basic (multigpu-create-close) [487.970906] Starting subtest: multigpu-create-close [487.974988] Subtest multigpu-create-close: SKIP (0.000s) [488.105102] [051/134] (532s left) kms_frontbuffer_tracking (fbc-suspend) [488.194174] Starting subtest: fbc-suspend [525.620102] Subtest fbc-suspend: SUCCESS (7.433s) [526.850726] [052/134] (493s left) gem_wait (wait) [526.924898] Starting subtest: wait [526.927307] Starting dynamic subtest: all-engines [528.208956] Dynamic subtest all-engines: SUCCESS (1.258s) [528.221380] Starting dynamic subtest: rcs0 [529.253160] Dynamic subtest rcs0: SUCCESS (1.026s) [529.264801] Starting dynamic subtest: bcs0 [530.300006] Dynamic subtest bcs0: SUCCESS (1.030s) [530.316319] Starting dynamic subtest: vcs0 [531.343920] Dynamic subtest vcs0: SUCCESS (1.030s) [531.355223] Starting dynamic subtest: vcs1 [532.389610] Dynamic subtest vcs1: SUCCESS (1.032s) [532.401687] Starting dynamic subtest: vecs0 [533.435143] Dynamic subtest vecs0: SUCCESS (1.033s) [533.447523] Starting dynamic subtest: ccs0 [534.482623] Dynamic subtest ccs0: SUCCESS (1.037s) [534.485057] Subtest wait: SUCCESS (7.460s) [534.697925] [053/134] (485s left) gem_exec_reloc (basic-wc-active) [534.783501] Subtest basic-wc-active: SKIP (0.000s) [534.904655] [054/134] (485s left) kms_pm_rpm (pc8-residency) [536.437479] Starting subtest: pc8-residency [536.442695] Subtest pc8-residency: SKIP (0.000s) [537.188259] [055/134] (483s left) kms_dsc (dsc-with-bpc-formats) [537.278404] Starting subtest: dsc-with-bpc-formats [537.392126] Subtest dsc-with-bpc-formats: SKIP (0.003s) [537.431022] [056/134] (482s left) kms_psr (pr-cursor-plane-move) [537.529455] Starting subtest: pr-cursor-plane-move [537.533592] Subtest pr-cursor-plane-move: SKIP (0.000s) [537.614969] [057/134] (482s left) kms_vblank (ts-continuation-dpms-suspend) [537.713488] Starting subtest: ts-continuation-dpms-suspend [537.715593] Starting dynamic subtest: pipe-A-eDP-1 [554.760218] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.990s) [554.777492] Starting dynamic subtest: pipe-D-eDP-1 [572.609885] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.360s) [572.612169] Subtest ts-continuation-dpms-suspend: SUCCESS (4.356s) [573.431455] [058/134] (447s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [573.493900] Starting subtest: multi-wait-available-unsubmitted-signaled [573.496308] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [573.598769] [059/134] (446s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [573.723516] Starting subtest: basic-flip-before-cursor-legacy [574.638670] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.913s) [575.462025] [060/134] (445s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [575.841496] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [576.671062] [061/134] (443s left) gem_exec_params (invalid-flag) [576.739025] Starting subtest: invalid-flag [576.741591] Subtest invalid-flag: SUCCESS (0.000s) [576.867628] [062/134] (443s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [576.968462] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [576.972567] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [577.100196] [063/134] (443s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [577.162118] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [577.164517] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [577.296061] [064/134] (443s left) prime_vgem (wait) [577.405806] Starting subtest: wait [577.408161] Starting dynamic subtest: rcs0 [577.464899] Dynamic subtest rcs0: SUCCESS (0.060s) [577.474084] Starting dynamic subtest: bcs0 [577.529342] Dynamic subtest bcs0: SUCCESS (0.063s) [577.539170] Starting dynamic subtest: vcs0 [577.576385] Dynamic subtest vcs0: SUCCESS (0.046s) [577.585720] Starting dynamic subtest: vcs1 [577.621670] Dynamic subtest vcs1: SUCCESS (0.045s) [577.631048] Starting dynamic subtest: vecs0 [577.668560] Dynamic subtest vecs0: SUCCESS (0.046s) [577.677734] Starting dynamic subtest: ccs0 [577.713024] Dynamic subtest ccs0: SUCCESS (0.044s) [577.715027] Subtest wait: SUCCESS (0.309s) [577.851667] [065/134] (442s left) gem_exec_capture (capture) [577.913549] Starting subtest: capture [577.915931] Starting dynamic subtest: rcs0-smem [578.743263] Dynamic subtest rcs0-smem: SUCCESS (0.825s) [578.752000] Starting dynamic subtest: bcs0-smem [579.561341] Dynamic subtest bcs0-smem: SUCCESS (0.818s) [579.570933] Starting dynamic subtest: vcs0-smem [580.371016] Dynamic subtest vcs0-smem: SUCCESS (0.804s) [580.389049] Starting dynamic subtest: vcs1-smem [581.686562] Dynamic subtest vcs1-smem: SUCCESS (1.313s) [581.698337] Starting dynamic subtest: vecs0-smem [582.578549] Dynamic subtest vecs0-smem: FAIL (0.832s) [582.589689] Starting dynamic subtest: ccs0-smem [583.842742] Dynamic subtest ccs0-smem: SUCCESS (1.321s) [583.845052] Subtest capture: FAIL (5.917s) [584.000284] [066/134] (436s left) kms_cursor_crc (cursor-rapid-movement-512x512) [584.293312] Starting subtest: cursor-rapid-movement-512x512 [584.296918] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [584.489405] [067/134] (436s left) kms_flip (2x-flip-vs-wf_vblank) [584.589268] Starting subtest: 2x-flip-vs-wf_vblank [584.600469] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s) [584.737201] [068/134] (436s left) i915_pm_freq_api (freq-suspend) [584.817597] Starting subtest: freq-suspend [584.819491] Starting dynamic subtest: gt0 [601.042439] Dynamic subtest gt0: SUCCESS (1.211s) [601.056055] Starting dynamic subtest: gt1 [617.066933] Dynamic subtest gt1: SUCCESS (1.191s) [617.069861] Subtest freq-suspend: SUCCESS (2.406s) [618.161232] [069/134] (403s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [618.276073] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [618.282053] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [618.403579] [070/134] (403s left) kms_chamelium_frames (hdmi-aspect-ratio) [618.792996] Subtest hdmi-aspect-ratio: SKIP (0.000s) [619.615393] [071/134] (402s left) kms_cursor_crc (cursor-sliding-max-size) [619.914044] Starting subtest: cursor-sliding-max-size [619.921877] Subtest cursor-sliding-max-size: SKIP (0.000s) [620.073846] [072/134] (401s left) kms_color_pipeline (plane-ctm3x4-lut1d) [620.175805] Starting subtest: plane-ctm3x4-lut1d [620.191962] Starting dynamic subtest: pipe-A-eDP-1 [620.937812] Dynamic subtest pipe-A-eDP-1: FAIL (0.305s) [621.543800] Starting dynamic subtest: pipe-B-eDP-1 [622.478838] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s) [622.896882] Starting dynamic subtest: pipe-C-eDP-1 [623.894632] Dynamic subtest pipe-C-eDP-1: FAIL (0.301s) [624.256762] Starting dynamic subtest: pipe-D-eDP-1 [625.221024] Dynamic subtest pipe-D-eDP-1: FAIL (0.256s) [625.223577] Subtest plane-ctm3x4-lut1d: FAIL (4.536s) [625.675866] [073/134] (396s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [625.782928] Starting subtest: psr-1p-pri-indfb-multidraw [648.612671] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.742s) [648.761242] [074/134] (373s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [648.870509] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [648.874659] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [648.970411] [075/134] (373s left) syncobj_timeline (invalid-query-illegal-handle) [649.028083] Starting subtest: invalid-query-illegal-handle [649.030403] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [649.156505] [076/134] (373s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [649.238587] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [649.240737] Starting dynamic subtest: pipe-A-eDP-1 [651.318631] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.080s) [651.327543] Starting dynamic subtest: pipe-B-eDP-1 [653.500882] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.180s) [653.510616] Starting dynamic subtest: pipe-C-eDP-1 [655.565890] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.064s) [655.576488] Starting dynamic subtest: pipe-D-eDP-1 [657.636700] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.071s) [657.638711] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.399s) [658.837488] [077/134] (363s left) kms_addfb_basic (too-high) [658.934741] Starting subtest: too-high [658.937058] Subtest too-high: SUCCESS (0.001s) [659.055438] [078/134] (363s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [659.160023] Starting subtest: psr-rgb565-draw-mmap-gtt [659.164832] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [659.280377] [079/134] (363s left) gem_mmap_offset (mmap-unmap) [659.345469] Starting subtest: mmap-unmap [659.347721] Starting dynamic subtest: smem0 [682.200922] Dynamic subtest smem0: SUCCESS (22.849s) [682.204053] Subtest mmap-unmap: SUCCESS (22.850s) [682.356340] [080/134] (340s left) gem_pread (exhaustion) [682.432025] Subtest exhaustion: SKIP (0.000s) [682.490088] [081/134] (339s left) kms_joiner (invalid-modeset-ultra-joiner) [682.592583] Starting subtest: invalid-modeset-ultra-joiner [682.597050] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [682.670634] [082/134] (339s left) i915_drm_fdinfo (basics) [682.706016] Starting subtest: basics [682.708363] Subtest basics: SUCCESS (0.000s) [682.781884] [083/134] (339s left) gem_ccs (ctrl-surf-copy-new-ctx) [682.843936] Starting subtest: ctrl-surf-copy-new-ctx [682.849328] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [682.982481] [084/134] (339s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [683.072694] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [683.098601] Starting dynamic subtest: pipe-A-plane-0 [683.787683] Dynamic subtest pipe-A-plane-0: SUCCESS (0.688s) [683.797388] Starting dynamic subtest: pipe-A-plane-3 [684.231400] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s) [684.241329] Starting dynamic subtest: pipe-A-plane-5 [684.245905] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [685.311287] Starting dynamic subtest: pipe-B-plane-0 [685.959537] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s) [685.968875] Starting dynamic subtest: pipe-B-plane-3 [686.392550] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s) [686.401709] Starting dynamic subtest: pipe-B-plane-5 [686.405656] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [686.704085] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.631s) [687.593371] [085/134] (335s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [687.693564] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [687.698793] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [687.811469] [086/134] (334s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [687.908228] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [687.910530] Starting dynamic subtest: pipe-A-default-mode [689.044541] Dynamic subtest pipe-A-default-mode: SKIP (1.134s) [689.049923] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.136s) [689.238386] [087/134] (333s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [689.348087] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [689.352766] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [689.470661] [088/134] (333s left) kms_draw_crc (fill-fb) [689.555919] Starting subtest: fill-fb [689.983469] Subtest fill-fb: SUCCESS (0.431s) [690.111255] [089/134] (332s left) kms_big_fb (y-tiled-8bpp-rotate-0) [690.213462] Starting subtest: y-tiled-8bpp-rotate-0 [690.217805] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [690.340237] [090/134] (332s left) gem_render_copy (yf-tiled-to-vebox-linear) [690.406549] Starting subtest: yf-tiled-to-vebox-linear [690.411764] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [690.605397] [091/134] (332s left) syncobj_wait (invalid-reset-illegal-handle) [690.669025] Starting subtest: invalid-reset-illegal-handle [690.671961] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [690.774469] [092/134] (332s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [690.874797] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [697.715305] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.840s) [697.886617] [093/134] (325s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [697.996583] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [698.001791] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [698.120799] [094/134] (324s left) api_intel_bb (full-batch) [698.176192] Starting subtest: full-batch [698.181857] Subtest full-batch: SUCCESS (0.007s) [698.331358] [095/134] (324s left) kms_psr (fbc-psr-basic) [698.434246] Starting subtest: fbc-psr-basic [698.436958] Starting dynamic subtest: eDP-1 [698.442017] Dynamic subtest eDP-1: SKIP (0.000s) [698.446937] Subtest fbc-psr-basic: SKIP (0.001s) [698.521056] [096/134] (324s left) gem_exercise_blt (fast-copy-emit) [698.584028] Starting subtest: fast-copy-emit [698.586602] Starting dynamic subtest: linear-smem-smem-emit [698.606739] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [698.621423] Starting dynamic subtest: xmajor-smem-smem-emit [698.623763] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s) [698.634701] Starting dynamic subtest: tile4-smem-smem-emit [698.642670] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.019s) [698.653792] Starting dynamic subtest: tile64-smem-smem-emit [698.662380] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.019s) [698.664694] Subtest fast-copy-emit: SUCCESS (0.079s) [698.799672] [097/134] (324s left) sysfs_heartbeat_interval (mixed) [698.873143] Starting subtest: mixed [698.875807] Starting dynamic subtest: vecs0 [704.089009] Dynamic subtest vecs0: SUCCESS (5.212s) [704.101639] Starting dynamic subtest: ccs0 [709.315561] Dynamic subtest ccs0: SUCCESS (5.222s) [709.327612] Starting dynamic subtest: vcs0 [714.519041] Dynamic subtest vcs0: SUCCESS (5.199s) [714.531530] Starting dynamic subtest: bcs0 [719.756715] Dynamic subtest bcs0: SUCCESS (5.239s) [719.768018] Starting dynamic subtest: rcs0 [724.987084] Dynamic subtest rcs0: SUCCESS (5.231s) [724.998693] Starting dynamic subtest: vcs1 [730.205317] Dynamic subtest vcs1: SUCCESS (5.218s) [730.208438] Subtest mixed: SUCCESS (31.333s) [730.302629] [098/134] (292s left) kms_cursor_legacy (cursor-vs-flip-legacy) [730.421462] Starting subtest: cursor-vs-flip-legacy [759.639367] Subtest cursor-vs-flip-legacy: SUCCESS (29.217s) [760.481768] [099/134] (262s left) gem_exec_schedule (semaphore-resolve) [760.561730] Starting subtest: semaphore-resolve [760.591948] Subtest semaphore-resolve: SUCCESS (0.041s) [760.952816] [100/134] (262s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [761.061016] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [761.065798] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [761.197001] [101/134] (262s left) kms_cursor_legacy (torture-bo) [761.324907] Starting subtest: torture-bo [761.327455] Starting dynamic subtest: pipe-A [767.065828] Dynamic subtest pipe-A: SUCCESS (5.737s) [767.084259] Starting dynamic subtest: pipe-B [773.874609] Dynamic subtest pipe-B: SUCCESS (6.806s) [773.886632] Starting dynamic subtest: pipe-C [780.929590] Dynamic subtest pipe-C: SUCCESS (7.050s) [780.941911] Starting dynamic subtest: pipe-D [787.965944] Dynamic subtest pipe-D: SUCCESS (7.031s) [787.978848] Starting dynamic subtest: all-pipes [794.765023] Dynamic subtest all-pipes: SUCCESS (6.795s) [794.767819] Subtest torture-bo: SUCCESS (33.432s) [794.938354] [102/134] (228s left) gem_ctx_shared (q-independent) [795.019567] Starting subtest: Q-independent [795.022553] Starting dynamic subtest: rcs0 [795.096527] Dynamic subtest rcs0: SUCCESS (0.077s) [795.112812] Starting dynamic subtest: vcs0 [795.156962] Dynamic subtest vcs0: SUCCESS (0.058s) [795.167113] Starting dynamic subtest: vcs1 [795.198184] Dynamic subtest vcs1: SUCCESS (0.040s) [795.208821] Starting dynamic subtest: vecs0 [795.250039] Dynamic subtest vecs0: SUCCESS (0.051s) [795.262297] Starting dynamic subtest: ccs0 [795.292962] Dynamic subtest ccs0: SUCCESS (0.042s) [795.295789] Subtest Q-independent: SUCCESS (0.274s) [796.676446] [103/134] (226s left) gem_exec_fence (syncobj-timeline-invalid-wait) [797.251453] Starting subtest: syncobj-timeline-invalid-wait [797.258304] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.006s) [798.707623] [104/134] (224s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [798.780559] Starting subtest: y-tiled-ccs-to-x-tiled [798.786357] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [799.001952] [105/134] (224s left) drm_read (short-buffer-wakeup) [799.152903] Starting subtest: short-buffer-wakeup [831.378814] Subtest short-buffer-wakeup: SUCCESS (32.216s) [831.535335] [106/134] (191s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [831.640817] Starting subtest: plane-use-after-nonblocking-unbind-fencing [831.643448] Starting dynamic subtest: pipe-A-eDP-1 [831.703035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s) [831.998468] Starting dynamic subtest: pipe-B-eDP-1 [832.773737] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.785s) [833.075656] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.435s) [833.948885] [107/134] (189s left) syncobj_timeline (device-submit-unordered) [834.009553] Starting subtest: device-submit-unordered [834.012413] Subtest device-submit-unordered: SUCCESS (0.000s) [834.115786] [108/134] (189s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [834.215513] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [834.218102] Starting dynamic subtest: pipe-A-eDP-1 [834.459858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.207s) [834.471197] Starting dynamic subtest: pipe-B-eDP-1 [835.711857] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.252s) [835.722022] Starting dynamic subtest: pipe-C-eDP-1 [836.925840] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s) [836.937223] Starting dynamic subtest: pipe-D-eDP-1 [838.152908] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s) [838.155888] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.898s) [839.288310] [109/134] (184s left) kms_pipe_crc_basic (nonblocking-crc) [839.391858] Starting subtest: nonblocking-crc [839.394667] Starting dynamic subtest: pipe-A-eDP-1 [840.174191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.783s) [840.189766] Starting dynamic subtest: pipe-B-eDP-1 [841.598498] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s) [841.608971] Starting dynamic subtest: pipe-C-eDP-1 [842.975777] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s) [842.987476] Starting dynamic subtest: pipe-D-eDP-1 [844.306029] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s) [844.308550] Subtest nonblocking-crc: SUCCESS (4.914s) [845.126081] [110/134] (178s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [845.234788] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [845.239721] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [845.331181] [111/134] (178s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [845.433043] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [845.438338] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [845.557523] [112/134] (178s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [845.657961] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [845.683564] Starting dynamic subtest: pipe-A-plane-0 [845.688902] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [845.699899] Starting dynamic subtest: pipe-A-plane-3 [845.705313] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [845.715287] Starting dynamic subtest: pipe-A-plane-5 [845.720262] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [846.807577] Starting dynamic subtest: pipe-B-plane-0 [846.812611] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [846.822359] Starting dynamic subtest: pipe-B-plane-3 [846.827567] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [846.837328] Starting dynamic subtest: pipe-B-plane-5 [846.841931] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [847.125845] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (1.467s) [847.995552] [113/134] (175s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [848.099028] Starting subtest: plane-downscale-factor-0-5-with-rotation [848.101821] Starting dynamic subtest: pipe-A [848.119839] Dynamic subtest pipe-A: SKIP (0.016s) [848.130172] Starting dynamic subtest: pipe-B [848.147869] Dynamic subtest pipe-B: SKIP (0.029s) [848.157843] Starting dynamic subtest: pipe-C [848.179248] Dynamic subtest pipe-C: SKIP (0.029s) [848.189566] Starting dynamic subtest: pipe-D [848.206122] Dynamic subtest pipe-D: SKIP (0.029s) [848.210572] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.106s) [848.340235] [114/134] (175s left) perf_pmu (busy-hang) [848.384554] Starting subtest: busy-hang [848.387149] Starting dynamic subtest: rcs0 [849.670881] Dynamic subtest rcs0: SUCCESS (1.284s) [849.681302] Starting dynamic subtest: bcs0 [850.901970] Dynamic subtest bcs0: SUCCESS (1.229s) [850.913755] Starting dynamic subtest: vcs0 [853.075074] Dynamic subtest vcs0: SUCCESS (2.171s) [853.087057] Starting dynamic subtest: vcs1 [855.109882] Dynamic subtest vcs1: SUCCESS (2.037s) [855.123012] Starting dynamic subtest: vecs0 [857.108372] Dynamic subtest vecs0: SUCCESS (1.992s) [857.130717] Starting dynamic subtest: ccs0 [858.350717] Dynamic subtest ccs0: SUCCESS (1.245s) [858.353802] Subtest busy-hang: SUCCESS (9.970s) [858.489276] [115/134] (165s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [858.592754] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [858.595457] Starting dynamic subtest: pipe-A-eDP-1 [859.404827] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.803s) [859.414946] Starting dynamic subtest: pipe-B-eDP-1 [861.031785] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.625s) [861.041310] Starting dynamic subtest: pipe-C-eDP-1 [862.550968] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.517s) [862.562301] Starting dynamic subtest: pipe-D-eDP-1 [864.049304] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.497s) [864.051803] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.449s) [865.216393] [116/134] (158s left) kms_cursor_crc (cursor-offscreen-128x42) [865.465230] Starting subtest: cursor-offscreen-128x42 [865.523042] Subtest cursor-offscreen-128x42: SKIP (0.054s) [865.784651] [117/134] (158s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [865.869746] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [865.872358] Starting dynamic subtest: pipe-A [865.891508] Dynamic subtest pipe-A: SKIP (0.017s) [865.901657] Starting dynamic subtest: pipe-B [865.921342] Dynamic subtest pipe-B: SKIP (0.031s) [865.931756] Starting dynamic subtest: pipe-C [865.953829] Dynamic subtest pipe-C: SKIP (0.031s) [865.963627] Starting dynamic subtest: pipe-D [865.986643] Dynamic subtest pipe-D: SKIP (0.030s) [865.991714] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.112s) [866.102870] [118/134] (157s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [866.211821] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [867.200951] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.990s) [867.347777] [119/134] (156s left) syncobj_basic (bad-pad-handle-to-fd) [867.416501] Starting subtest: bad-pad-handle-to-fd [867.418972] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [867.538072] [120/134] (156s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [867.663398] Starting subtest: cursorA-vs-flipB-atomic-transitions [867.668230] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [867.822492] [121/134] (156s left) kms_frontbuffer_tracking (psr-2p-rte) [867.928740] Starting subtest: psr-2p-rte [867.932796] Subtest psr-2p-rte: SKIP (0.000s) [868.051807] [122/134] (156s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [868.152433] Starting subtest: psr-shrfb-scaledprimary [873.946860] Subtest psr-shrfb-scaledprimary: SUCCESS (5.796s) [874.095544] [123/134] (150s left) gen7_exec_parse (cmd-crossing-page) [874.162934] Subtest cmd-crossing-page: SKIP (0.000s) [874.235395] [124/134] (150s left) kms_frontbuffer_tracking (fbc-1p-rte) [874.338516] Starting subtest: fbc-1p-rte [879.801248] Subtest fbc-1p-rte: SUCCESS (5.467s) [880.944107] [125/134] (143s left) gem_mmap_wc (write) [881.010810] Subtest write: SKIP (0.000s) [881.066363] [126/134] (143s left) kms_busy (extended-modeset-hang-newfb) [881.186963] Starting subtest: extended-modeset-hang-newfb [881.189722] Starting dynamic subtest: pipe-A [915.543953] Dynamic subtest pipe-A: SUCCESS (34.354s) [915.567336] Starting dynamic subtest: pipe-D [938.440827] Dynamic subtest pipe-D: SUCCESS (22.890s) [938.443627] Subtest extended-modeset-hang-newfb: SUCCESS (57.248s) [939.240524] [127/134] ( 85s left) i915_pm_rpm (gem-evict-pwrite) [940.776371] Starting subtest: gem-evict-pwrite [940.782235] Subtest gem-evict-pwrite: SKIP (0.000s) [941.503862] [128/134] ( 82s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [941.602295] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [941.604643] Starting dynamic subtest: pipe-A-eDP-1 [941.627775] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [941.639822] Starting dynamic subtest: pipe-B-eDP-1 [941.662747] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [941.672364] Starting dynamic subtest: pipe-C-eDP-1 [941.699048] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [941.709518] Starting dynamic subtest: pipe-D-eDP-1 [941.735815] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [941.740582] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.006s) [943.864250] [129/134] ( 80s left) i915_suspend (basic-s2idle-without-i915) [943.903705] Starting subtest: basic-s2idle-without-i915 [964.529638] Subtest basic-s2idle-without-i915: SUCCESS (5.045s) [964.655008] [130/134] ( 59s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [964.756493] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [964.758613] Starting dynamic subtest: pipe-A-default-mode [967.491311] Dynamic subtest pipe-A-default-mode: SUCCESS (2.739s) [967.493540] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.741s) [968.347617] [131/134] ( 56s left) kms_big_fb (4-tiled-addfb) [968.454100] Starting subtest: 4-tiled-addfb [968.456350] Subtest 4-tiled-addfb: SUCCESS (0.000s) [968.602289] [132/134] ( 56s left) kms_setmode (basic-clone-single-crtc) [968.656905] Starting subtest: basic-clone-single-crtc [968.663339] Subtest basic-clone-single-crtc: SKIP (0.000s) [968.789320] [133/134] ( 55s left) gem_exec_balancer (full-late-pulse) [968.862279] Starting subtest: full-late-pulse [974.006478] Subtest full-late-pulse: SUCCESS (5.147s) [974.361579] [134/134] ( 50s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [974.475259] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [974.479108] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [974.585292] 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.