[58.727102] Initializing watchdogs [58.727232] /dev/watchdog0 [58.745104] [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.749364] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.751640] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.754874] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [58.877708] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [66.272923] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.375s) [66.452798] [002/134] (952s left) gem_exec_params (secure-non-master) [66.517897] Starting subtest: secure-non-master [66.522305] Subtest secure-non-master: SKIP (0.000s) [66.648232] [003/134] (952s left) tools_test (tools_test) [66.697020] Starting subtest: tools_test [66.752916] Subtest tools_test: SUCCESS (0.073s) [66.823160] [004/134] (952s left) kms_selftest (drm_cmdline_parser) [66.867125] Starting subtest: drm_cmdline_parser [66.878875] Starting dynamic subtest: drm_test_cmdline_force_d_only [67.606406] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.725s) [67.613482] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [67.915604] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.308s) [67.925078] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [68.280422] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.363s) [68.288819] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [68.425250] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.144s) [68.433743] Starting dynamic subtest: drm_test_cmdline_force_e_only [68.579240] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.153s) [68.587507] Starting dynamic subtest: drm_test_cmdline_res [68.724265] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.144s) [68.731986] Starting dynamic subtest: drm_test_cmdline_res_vesa [68.833611] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.109s) [68.840382] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [68.981277] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.147s) [68.987947] Starting dynamic subtest: drm_test_cmdline_res_rblank [69.126332] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.144s) [69.134986] Starting dynamic subtest: drm_test_cmdline_res_bpp [69.275321] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.147s) [69.283750] Starting dynamic subtest: drm_test_cmdline_res_refresh [69.399321] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.124s) [69.408038] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [69.545724] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.146s) [69.553929] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [69.677215] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.131s) [69.684898] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [69.780329] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.102s) [69.787196] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [69.910266] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.129s) [69.919076] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [70.044240] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.132s) [70.052583] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [70.182070] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.137s) [70.188970] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [70.296221] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.114s) [70.305084] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [70.438255] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.142s) [70.446873] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [70.582116] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.143s) [70.590831] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [70.693136] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.112s) [70.701621] Starting dynamic subtest: drm_test_cmdline_name [70.808126] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.114s) [70.814953] Starting dynamic subtest: drm_test_cmdline_name_bpp [70.943284] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.135s) [70.951664] Starting dynamic subtest: drm_test_cmdline_name_option [71.062049] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.119s) [71.068496] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [71.175094] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.112s) [71.181443] Starting dynamic subtest: drm_test_cmdline_rotate_0 [71.281095] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.106s) [71.287365] Starting dynamic subtest: drm_test_cmdline_rotate_90 [71.407204] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.124s) [71.414247] Starting dynamic subtest: drm_test_cmdline_rotate_180 [71.511870] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.106s) [71.518457] Starting dynamic subtest: drm_test_cmdline_rotate_270 [71.618980] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.107s) [71.625625] Starting dynamic subtest: drm_test_cmdline_hmirror [71.748467] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.128s) [71.757053] Starting dynamic subtest: drm_test_cmdline_vmirror [71.866564] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.117s) [71.873641] Starting dynamic subtest: drm_test_cmdline_margin_options [72.023340] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.156s) [72.030626] Starting dynamic subtest: drm_test_cmdline_multiple_options [72.122412] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.100s) [72.130276] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [72.205197] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.083s) [72.213818] Starting dynamic subtest: drm_test_cmdline_extra_and_option [72.342583] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.136s) [72.351223] Starting dynamic subtest: drm_test_cmdline_freestanding_options [72.462472] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.120s) [72.471060] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [72.558478] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.097s) [72.566604] Starting dynamic subtest: drm_test_cmdline_panel_orientation [72.669122] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.110s) [72.677129] Starting dynamic subtest: drm_test_cmdline_invalid [72.815292] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.146s) [72.823031] Starting dynamic subtest: drm_test_cmdline_tv_options [72.970044] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.153s) [72.972316] Subtest drm_cmdline_parser: SUCCESS (6.093s) [73.207413] [005/134] (946s left) gem_exec_suspend (basic-s0) [73.281043] Starting subtest: basic-S0 [73.283497] Starting dynamic subtest: smem [93.938115] Dynamic subtest smem: SUCCESS (6.568s) [93.941231] Subtest basic-S0: SUCCESS (6.569s) [94.149832] [006/134] (925s left) kms_content_protection (uevent) [94.312931] Starting subtest: uevent [94.317727] Subtest uevent: SKIP (0.000s) [94.471239] [007/134] (925s left) gem_eio (in-flight-suspend) [94.720152] Starting subtest: in-flight-suspend [137.404035] Subtest in-flight-suspend: SUCCESS (13.148s) [137.539016] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true [137.541964] [008/134] (881s left) gem_spin_batch (resubmit-all) [137.634112] Starting subtest: resubmit-all [137.636600] Starting dynamic subtest: rcs0 [137.645287] Dynamic subtest rcs0: SUCCESS (0.011s) [137.657634] Starting dynamic subtest: bcs0 [137.660189] Dynamic subtest bcs0: SUCCESS (0.002s) [137.668589] Starting dynamic subtest: vcs0 [137.670466] Dynamic subtest vcs0: SUCCESS (0.004s) [137.678532] Starting dynamic subtest: vcs1 [137.680493] Dynamic subtest vcs1: SUCCESS (0.002s) [137.689213] Starting dynamic subtest: vecs0 [137.691171] Dynamic subtest vecs0: SUCCESS (0.002s) [137.698930] Starting dynamic subtest: ccs0 [137.700846] Dynamic subtest ccs0: SUCCESS (0.003s) [137.702783] Subtest resubmit-all: SUCCESS (0.027s) [139.366323] [009/134] (880s left) kms_psr (psr-cursor-plane-onoff) [139.464522] Starting subtest: psr-cursor-plane-onoff [139.466813] Starting dynamic subtest: eDP-1 [141.223172] Dynamic subtest eDP-1: SUCCESS (1.721s) [141.225621] Subtest psr-cursor-plane-onoff: SUCCESS (1.722s) [142.129575] [010/134] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [142.221347] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [149.170642] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.873s) [149.358792] [011/134] (870s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [149.463954] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [149.468120] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [149.594789] [012/134] (870s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [154.654165] Starting subtest: fbc-psr2-cursor-plane-update-sf [154.656445] Starting dynamic subtest: pipe-A-eDP-1 [155.448757] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s) [155.458898] Starting dynamic subtest: pipe-B-eDP-1 [156.578447] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [156.582643] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.916s) [157.781557] [013/134] (861s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [162.879336] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [162.881753] Starting dynamic subtest: pipe-A-eDP-1 [169.480152] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.591s) [169.489502] Starting dynamic subtest: pipe-B-eDP-1 [176.428145] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.945s) [176.430440] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.541s) [177.327231] [014/134] (842s left) kms_pm_rpm (basic-pci-d3-state) [179.501689] Starting subtest: basic-pci-d3-state [180.970010] Subtest basic-pci-d3-state: SUCCESS (1.470s) [181.115623] [015/134] (838s left) gem_ctx_exec (basic-norecovery) [181.186050] Starting subtest: basic-norecovery [181.548195] Subtest basic-norecovery: SUCCESS (0.362s) [181.694776] [016/134] (838s left) gem_pxp (protected-encrypted-src-copy-not-readible) [181.812034] Starting subtest: protected-encrypted-src-copy-not-readible [181.925091] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s) [182.080191] [017/134] (837s left) kms_flip (absolute-wf_vblank) [182.180802] Starting subtest: absolute-wf_vblank [182.183095] Starting dynamic subtest: A-eDP1 [190.890511] Dynamic subtest A-eDP1: SUCCESS (8.709s) [190.899788] Starting dynamic subtest: B-eDP1 [199.626582] Dynamic subtest B-eDP1: SUCCESS (8.732s) [199.636957] Starting dynamic subtest: C-eDP1 [208.354036] Dynamic subtest C-eDP1: SUCCESS (8.725s) [208.365801] Starting dynamic subtest: D-eDP1 [217.090616] Dynamic subtest D-eDP1: SUCCESS (8.731s) [217.092794] Subtest absolute-wf_vblank: SUCCESS (34.904s) [218.310754] [018/134] (801s left) prime_mmap (test_refcounting) [218.371533] Starting subtest: test_refcounting [218.373410] Starting dynamic subtest: test_refcounting-smem [218.403956] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s) [218.406334] Subtest test_refcounting: SUCCESS (0.035s) [218.510397] [019/134] (801s left) gem_exec_schedule (pi-common) [218.689785] Starting subtest: pi-common [218.692353] Starting dynamic subtest: rcs0 [218.718679] Dynamic subtest rcs0: SUCCESS (0.033s) [218.728421] Starting dynamic subtest: bcs0 [218.754009] Dynamic subtest bcs0: SUCCESS (0.035s) [218.767525] Starting dynamic subtest: vcs0 [218.784349] Dynamic subtest vcs0: SUCCESS (0.030s) [218.797548] Starting dynamic subtest: vcs1 [218.812566] Dynamic subtest vcs1: SUCCESS (0.028s) [218.825997] Starting dynamic subtest: vecs0 [218.838895] Dynamic subtest vecs0: SUCCESS (0.026s) [218.852033] Starting dynamic subtest: ccs0 [218.865508] Dynamic subtest ccs0: SUCCESS (0.026s) [218.867815] Subtest pi-common: SUCCESS (0.181s) [219.105532] [020/134] (800s left) perf (unprivileged-single-ctx-counters) [219.233842] Starting subtest: unprivileged-single-ctx-counters [219.237453] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [219.279853] [021/134] (800s left) api_intel_allocator (fork-simple-stress-signal) [219.340706] Starting subtest: fork-simple-stress-signal [224.745431] Subtest fork-simple-stress-signal: SUCCESS (5.403s) [224.896088] [022/134] (795s left) kms_flip (flip-vs-panning-vs-hang) [225.006245] Starting subtest: flip-vs-panning-vs-hang [225.008644] Starting dynamic subtest: A-eDP1 [276.826929] Dynamic subtest A-eDP1: SUCCESS (51.819s) [276.838010] Starting dynamic subtest: D-eDP1 [315.806354] Dynamic subtest D-eDP1: SUCCESS (38.969s) [315.808661] Subtest flip-vs-panning-vs-hang: SUCCESS (90.792s) [317.110956] [023/134] (703s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [322.175407] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [322.177785] Starting dynamic subtest: pipe-A-eDP-1 [334.210719] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.030s) [334.220624] Starting dynamic subtest: pipe-B-eDP-1 [346.234585] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.018s) [346.236758] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.052s) [347.094004] [024/134] (673s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [347.160054] Starting subtest: invalid-multi-wait-unsubmitted-submitted [347.161976] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [347.270298] [025/134] (672s left) gem_exec_create (basic) [347.327018] Starting subtest: basic [347.329365] Starting dynamic subtest: smem [351.279221] Dynamic subtest smem: SUCCESS (3.949s) [351.281827] Subtest basic: SUCCESS (3.950s) [351.488554] [026/134] (668s left) gem_ctx_persistence (smoketest) [351.546041] Starting subtest: smoketest [392.268453] Subtest smoketest: SUCCESS (40.724s) [392.357737] [027/134] (627s left) gem_ctx_bad_destroy (invalid-pad) [392.401230] Starting subtest: invalid-pad [392.403580] Subtest invalid-pad: SUCCESS (0.000s) [392.479585] [028/134] (627s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [392.595146] Starting subtest: cursorA-vs-flipB-legacy [392.599537] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [392.753655] [029/134] (627s left) kms_atomic_interruptible (legacy-setmode) [392.843559] Starting subtest: legacy-setmode [392.845814] Starting dynamic subtest: pipe-A-eDP-1 [399.759876] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.914s) [399.762240] Subtest legacy-setmode: SUCCESS (6.915s) [400.643437] [030/134] (619s left) kms_cdclk (mode-transition) [400.743860] Starting subtest: mode-transition [400.746156] Starting dynamic subtest: pipe-A-eDP-1 [401.041685] Dynamic subtest pipe-A-eDP-1: SKIP (0.297s) [401.050744] Starting dynamic subtest: pipe-B-eDP-1 [401.055336] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [401.063755] Starting dynamic subtest: pipe-C-eDP-1 [401.068333] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [401.076852] Starting dynamic subtest: pipe-D-eDP-1 [401.081467] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [401.085906] Subtest mode-transition: SKIP (0.304s) [401.890243] [031/134] (618s left) kms_big_fb (linear-8bpp-rotate-270) [402.002868] Starting subtest: linear-8bpp-rotate-270 [402.025643] Subtest linear-8bpp-rotate-270: SKIP (0.022s) [402.176068] [032/134] (618s left) perf_pmu (faulting-read) [402.219139] Starting subtest: faulting-read [402.221353] Starting dynamic subtest: wb [402.223677] Dynamic subtest wb: SUCCESS (0.001s) [402.237146] Starting dynamic subtest: wc [402.238988] Dynamic subtest wc: SUCCESS (0.000s) [402.247987] Starting dynamic subtest: uc [402.249875] Dynamic subtest uc: SUCCESS (0.000s) [402.251740] Subtest faulting-read: SUCCESS (0.003s) [402.362747] [033/134] (618s left) kms_psr (fbc-psr2-primary-render) [402.458102] Starting subtest: fbc-psr2-primary-render [402.460412] Starting dynamic subtest: eDP-1 [402.464781] Dynamic subtest eDP-1: SKIP (0.000s) [402.469129] Subtest fbc-psr2-primary-render: SKIP (0.001s) [402.540233] [034/134] (618s left) gem_exec_schedule (deep) [402.732453] Starting subtest: deep [402.734818] Starting dynamic subtest: rcs0 [408.042488] Dynamic subtest rcs0: SKIP (5.308s) [408.053270] Starting dynamic subtest: vcs0 [419.141675] Dynamic subtest vcs0: SUCCESS (11.100s) [419.153129] Starting dynamic subtest: vcs1 [430.765161] Dynamic subtest vcs1: SUCCESS (11.622s) [430.776760] Starting dynamic subtest: vecs0 [442.601497] Dynamic subtest vecs0: SUCCESS (11.834s) [442.616290] Starting dynamic subtest: ccs0 [455.127602] Dynamic subtest ccs0: SUCCESS (12.524s) [455.130892] Subtest deep: SUCCESS (52.392s) [456.079062] [035/134] (564s left) kms_selftest (drm_plane_helper) [456.117689] Starting subtest: drm_plane_helper [456.203257] Starting dynamic subtest: drm_test_check_plane_state [456.326915] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.125s) [456.338144] Starting dynamic subtest: drm_test_check_invalid_plane_state [456.420837] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.092s) [456.423257] Subtest drm_plane_helper: SUCCESS (0.305s) [456.620614] [036/134] (564s left) syncobj_basic (bad-pad-fd-to-handle) [456.676364] Starting subtest: bad-pad-fd-to-handle [456.678659] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [456.799990] [037/134] (563s left) gem_lmem_swapping (parallel-random-engines) [456.848836] Subtest parallel-random-engines: SKIP (0.000s) [456.896082] [038/134] (563s left) kms_mmap_write_crc (main) [456.997750] Starting subtest: main [457.001729] Starting dynamic subtest: pipe-A-eDP-1 [460.664310] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.662s) [460.666324] Subtest main: SUCCESS (3.664s) [461.509416] [039/134] (559s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [461.613306] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [468.488105] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.875s) [468.634646] [040/134] (552s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [468.735212] Starting subtest: addfb25-yf-tiled-legacy [468.737439] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [468.857144] [041/134] (552s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [468.954511] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [468.958690] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [469.042288] [042/134] (551s left) gem_ctx_exec (basic) [469.107981] Starting subtest: basic [469.112406] Subtest basic: SUCCESS (0.005s) [469.238115] [043/134] (551s left) kms_atomic (test-only) [469.326083] Starting subtest: test-only [469.376855] Starting dynamic subtest: pipe-A-eDP-1 [471.928099] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.550s) [471.930092] Subtest test-only: SUCCESS (2.602s) [472.812409] [044/134] (548s left) gem_set_tiling_vs_gtt [472.949754] [045/134] (548s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [473.062235] Starting subtest: yf-tiled-16bpp-rotate-0 [473.066350] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [473.205080] [046/134] (547s left) kms_getfb (getfb2-handle-zero) [473.307377] Starting subtest: getfb2-handle-zero [473.309287] Subtest getfb2-handle-zero: SUCCESS (0.000s) [473.439551] [047/134] (547s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [473.500332] Starting subtest: single-wait-all-for-submit-available-submitted [473.502514] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [473.625059] [048/134] (547s left) gem_exec_reloc (basic-wc-cpu) [473.695587] Subtest basic-wc-cpu: SKIP (0.000s) [473.782423] [049/134] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [473.881309] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [481.045791] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.166s) [481.216427] [050/134] (540s left) gem_basic (multigpu-create-close) [481.276508] Starting subtest: multigpu-create-close [481.280605] Subtest multigpu-create-close: SKIP (0.000s) [481.373496] [051/134] (539s left) kms_frontbuffer_tracking (fbc-suspend) [481.482087] Starting subtest: fbc-suspend [519.636572] Subtest fbc-suspend: SUCCESS (7.538s) [520.868293] [052/134] (500s left) gem_wait (wait) [520.954041] Starting subtest: wait [520.956485] Starting dynamic subtest: all-engines [522.853128] Dynamic subtest all-engines: SUCCESS (1.863s) [522.865720] Starting dynamic subtest: rcs0 [523.900075] Dynamic subtest rcs0: SUCCESS (1.030s) [523.912295] Starting dynamic subtest: bcs0 [524.949311] Dynamic subtest bcs0: SUCCESS (1.033s) [524.961058] Starting dynamic subtest: vcs0 [525.993950] Dynamic subtest vcs0: SUCCESS (1.031s) [526.005885] Starting dynamic subtest: vcs1 [527.040322] Dynamic subtest vcs1: SUCCESS (1.034s) [527.052048] Starting dynamic subtest: vecs0 [528.086480] Dynamic subtest vecs0: SUCCESS (1.035s) [528.098465] Starting dynamic subtest: ccs0 [529.134167] Dynamic subtest ccs0: SUCCESS (1.038s) [529.136691] Subtest wait: SUCCESS (8.079s) [529.356149] [053/134] (492s left) gem_exec_reloc (basic-wc-active) [529.420712] Subtest basic-wc-active: SKIP (0.000s) [529.508039] [054/134] (491s left) kms_pm_rpm (pc8-residency) [531.033602] Starting subtest: pc8-residency [531.038831] Subtest pc8-residency: SKIP (0.000s) [531.827769] [055/134] (489s left) kms_dsc (dsc-with-bpc-formats) [531.914214] Starting subtest: dsc-with-bpc-formats [532.027296] Subtest dsc-with-bpc-formats: SKIP (0.003s) [532.066913] [056/134] (489s left) kms_psr (pr-cursor-plane-move) [532.154418] Starting subtest: pr-cursor-plane-move [532.158754] Subtest pr-cursor-plane-move: SKIP (0.000s) [532.242117] [057/134] (489s left) kms_vblank (ts-continuation-dpms-suspend) [532.342680] Starting subtest: ts-continuation-dpms-suspend [532.344539] Starting dynamic subtest: pipe-A-eDP-1 [549.633595] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.830s) [549.648803] Starting dynamic subtest: pipe-D-eDP-1 [567.646711] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.472s) [567.649222] Subtest ts-continuation-dpms-suspend: SUCCESS (4.305s) [568.492079] [058/134] (453s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [568.559772] Starting subtest: multi-wait-available-unsubmitted-signaled [568.561737] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [568.672015] [059/134] (452s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [568.790355] Starting subtest: basic-flip-before-cursor-legacy [569.728621] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.915s) [570.593023] [060/134] (451s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [570.991259] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [571.804159] [061/134] (449s left) gem_exec_params (invalid-flag) [571.862669] Starting subtest: invalid-flag [571.865207] Subtest invalid-flag: SUCCESS (0.000s) [571.982172] [062/134] (449s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [572.088198] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [572.092040] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [572.199172] [063/134] (449s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [572.257793] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [572.260277] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [572.393658] [064/134] (449s left) prime_vgem (wait) [572.466899] Starting subtest: wait [572.469329] Starting dynamic subtest: rcs0 [572.530501] Dynamic subtest rcs0: SUCCESS (0.062s) [572.540403] Starting dynamic subtest: bcs0 [572.596318] Dynamic subtest bcs0: SUCCESS (0.064s) [572.605730] Starting dynamic subtest: vcs0 [572.641742] Dynamic subtest vcs0: SUCCESS (0.043s) [572.650894] Starting dynamic subtest: vcs1 [572.690455] Dynamic subtest vcs1: SUCCESS (0.047s) [572.699750] Starting dynamic subtest: vecs0 [572.735005] Dynamic subtest vecs0: SUCCESS (0.043s) [572.744257] Starting dynamic subtest: ccs0 [572.780630] Dynamic subtest ccs0: SUCCESS (0.044s) [572.782665] Subtest wait: SUCCESS (0.310s) [572.921481] [065/134] (448s left) gem_exec_capture (capture) [572.985832] Starting subtest: capture [572.987639] Starting dynamic subtest: rcs0-smem [573.803697] Dynamic subtest rcs0-smem: SUCCESS (0.806s) [573.812870] Starting dynamic subtest: bcs0-smem [574.618449] Dynamic subtest bcs0-smem: SUCCESS (0.803s) [574.628027] Starting dynamic subtest: vcs0-smem [575.436141] Dynamic subtest vcs0-smem: SUCCESS (0.805s) [575.444696] Starting dynamic subtest: vcs1-smem [576.755074] Dynamic subtest vcs1-smem: SUCCESS (1.304s) [576.763888] Starting dynamic subtest: vecs0-smem [577.643951] Dynamic subtest vecs0-smem: FAIL (0.828s) [577.654564] Starting dynamic subtest: ccs0-smem [578.916475] Dynamic subtest ccs0-smem: SUCCESS (1.314s) [578.918837] Subtest capture: FAIL (5.865s) [579.054297] [066/134] (442s left) kms_cursor_crc (cursor-rapid-movement-512x512) [579.318528] Starting subtest: cursor-rapid-movement-512x512 [579.322951] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [579.492030] [067/134] (442s left) kms_flip (2x-flip-vs-wf_vblank) [579.606089] Starting subtest: 2x-flip-vs-wf_vblank [579.615933] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s) [579.708455] [068/134] (442s left) i915_pm_freq_api (freq-suspend) [579.779842] Starting subtest: freq-suspend [579.782258] Starting dynamic subtest: gt0 [596.124418] Dynamic subtest gt0: SUCCESS (1.258s) [596.136727] Starting dynamic subtest: gt1 [612.084128] Dynamic subtest gt1: SUCCESS (1.207s) [612.086409] Subtest freq-suspend: SUCCESS (2.469s) [612.180851] [069/134] (409s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [612.295814] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [612.301319] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [612.403996] [070/134] (409s left) kms_chamelium_frames (hdmi-aspect-ratio) [612.821706] Subtest hdmi-aspect-ratio: SKIP (0.000s) [613.693954] [071/134] (408s left) kms_cursor_crc (cursor-sliding-max-size) [614.019691] Starting subtest: cursor-sliding-max-size [614.028036] Subtest cursor-sliding-max-size: SKIP (0.000s) [614.188918] [072/134] (408s left) kms_color_pipeline (plane-ctm3x4-lut1d) [614.293210] Starting subtest: plane-ctm3x4-lut1d [614.307448] Starting dynamic subtest: pipe-A-eDP-1 [615.048064] Dynamic subtest pipe-A-eDP-1: FAIL (0.316s) [615.754918] Starting dynamic subtest: pipe-B-eDP-1 [616.669545] Dynamic subtest pipe-B-eDP-1: FAIL (0.312s) [617.211679] Starting dynamic subtest: pipe-C-eDP-1 [618.237037] Dynamic subtest pipe-C-eDP-1: FAIL (0.301s) [618.559292] Starting dynamic subtest: pipe-D-eDP-1 [619.477062] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s) [619.479425] Subtest plane-ctm3x4-lut1d: FAIL (4.704s) [619.969963] [073/134] (402s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [620.078194] Starting subtest: psr-1p-pri-indfb-multidraw [643.033306] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.860s) [643.159680] [074/134] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [643.268716] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [643.272802] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [643.377074] [075/134] (378s left) syncobj_timeline (invalid-query-illegal-handle) [643.431885] Starting subtest: invalid-query-illegal-handle [643.434201] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [643.578116] [076/134] (378s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [643.671677] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [643.673613] Starting dynamic subtest: pipe-A-eDP-1 [645.895738] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.224s) [645.904877] Starting dynamic subtest: pipe-B-eDP-1 [648.310579] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.413s) [648.321728] Starting dynamic subtest: pipe-C-eDP-1 [650.454558] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.144s) [650.464266] Starting dynamic subtest: pipe-D-eDP-1 [652.621148] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.165s) [652.623816] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.950s) [653.837075] [077/134] (368s left) kms_addfb_basic (too-high) [653.940663] Starting subtest: too-high [653.943321] Subtest too-high: SUCCESS (0.001s) [654.049810] [078/134] (368s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [654.153086] Starting subtest: psr-rgb565-draw-mmap-gtt [654.158038] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [654.275236] [079/134] (368s left) gem_mmap_offset (mmap-unmap) [654.343285] Starting subtest: mmap-unmap [654.345954] Starting dynamic subtest: smem0 [678.014416] Dynamic subtest smem0: SUCCESS (23.666s) [678.017405] Subtest mmap-unmap: SUCCESS (23.668s) [678.169973] [080/134] (344s left) gem_pread (exhaustion) [678.241307] Subtest exhaustion: SKIP (0.000s) [678.309182] [081/134] (344s left) kms_joiner (invalid-modeset-ultra-joiner) [678.420250] Starting subtest: invalid-modeset-ultra-joiner [678.425876] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [678.494789] [082/134] (344s left) i915_drm_fdinfo (basics) [678.542876] Starting subtest: basics [678.545262] Subtest basics: SUCCESS (0.000s) [678.623284] [083/134] (344s left) gem_ccs (ctrl-surf-copy-new-ctx) [678.696232] Starting subtest: ctrl-surf-copy-new-ctx [678.701236] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [678.837816] [084/134] (343s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [678.927408] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [678.954733] Starting dynamic subtest: pipe-A-plane-0 [679.667220] Dynamic subtest pipe-A-plane-0: SUCCESS (0.711s) [679.684195] Starting dynamic subtest: pipe-A-plane-3 [680.087626] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s) [680.099223] Starting dynamic subtest: pipe-A-plane-5 [680.103665] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [681.216932] Starting dynamic subtest: pipe-B-plane-0 [681.888331] Dynamic subtest pipe-B-plane-0: SUCCESS (0.678s) [681.900334] Starting dynamic subtest: pipe-B-plane-3 [682.343366] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s) [682.352417] Starting dynamic subtest: pipe-B-plane-5 [682.356696] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [682.653107] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.724s) [683.500388] [085/134] (339s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [683.616456] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [683.622085] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [683.744357] [086/134] (339s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [683.841188] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [683.844094] Starting dynamic subtest: pipe-A-default-mode [684.966427] Dynamic subtest pipe-A-default-mode: SKIP (1.122s) [684.971883] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.124s) [685.159977] [087/134] (337s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [685.262263] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [685.267162] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [685.364610] [088/134] (337s left) kms_draw_crc (fill-fb) [685.463122] Starting subtest: fill-fb [685.992666] Subtest fill-fb: SUCCESS (0.531s) [686.107678] [089/134] (336s left) kms_big_fb (y-tiled-8bpp-rotate-0) [686.219950] Starting subtest: y-tiled-8bpp-rotate-0 [686.224256] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [686.342426] [090/134] (336s left) gem_render_copy (yf-tiled-to-vebox-linear) [686.398109] Starting subtest: yf-tiled-to-vebox-linear [686.402561] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [686.592662] [091/134] (336s left) syncobj_wait (invalid-reset-illegal-handle) [686.667289] Starting subtest: invalid-reset-illegal-handle [686.669944] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [686.795179] [092/134] (336s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [686.895128] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [693.909214] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.015s) [694.089766] [093/134] (328s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [694.206037] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [694.211220] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [694.325938] [094/134] (328s left) api_intel_bb (full-batch) [694.387276] Starting subtest: full-batch [694.393279] Subtest full-batch: SUCCESS (0.007s) [694.481237] [095/134] (328s left) kms_psr (fbc-psr-basic) [694.578680] Starting subtest: fbc-psr-basic [694.581166] Starting dynamic subtest: eDP-1 [694.586155] Dynamic subtest eDP-1: SKIP (0.000s) [694.590997] Subtest fbc-psr-basic: SKIP (0.001s) [694.666261] [096/134] (328s left) gem_exercise_blt (fast-copy-emit) [694.725464] Starting subtest: fast-copy-emit [694.728038] Starting dynamic subtest: linear-smem-smem-emit [694.748404] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s) [694.758295] Starting dynamic subtest: xmajor-smem-smem-emit [694.766133] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [694.775350] Starting dynamic subtest: tile4-smem-smem-emit [694.782981] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s) [694.792204] Starting dynamic subtest: tile64-smem-smem-emit [694.803462] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.020s) [694.806170] Subtest fast-copy-emit: SUCCESS (0.078s) [694.955079] [097/134] (328s left) sysfs_heartbeat_interval (mixed) [695.016365] Starting subtest: mixed [695.019023] Starting dynamic subtest: vecs0 [700.277582] Dynamic subtest vecs0: SUCCESS (5.257s) [700.290222] Starting dynamic subtest: ccs0 [705.482448] Dynamic subtest ccs0: SUCCESS (5.200s) [705.494469] Starting dynamic subtest: vcs0 [710.689408] Dynamic subtest vcs0: SUCCESS (5.205s) [710.701351] Starting dynamic subtest: bcs0 [715.949853] Dynamic subtest bcs0: SUCCESS (5.260s) [715.961684] Starting dynamic subtest: rcs0 [721.140962] Dynamic subtest rcs0: SUCCESS (5.190s) [721.151422] Starting dynamic subtest: vcs1 [726.328069] Dynamic subtest vcs1: SUCCESS (5.187s) [726.331336] Subtest mixed: SUCCESS (31.312s) [726.422898] [098/134] (296s left) kms_cursor_legacy (cursor-vs-flip-legacy) [726.558363] Starting subtest: cursor-vs-flip-legacy [756.060313] Subtest cursor-vs-flip-legacy: SUCCESS (29.503s) [756.896696] [099/134] (266s left) gem_exec_schedule (semaphore-resolve) [756.975875] Starting subtest: semaphore-resolve [757.000289] Subtest semaphore-resolve: SUCCESS (0.036s) [757.357581] [100/134] (266s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [757.453890] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [757.458978] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [757.573935] [101/134] (265s left) kms_cursor_legacy (torture-bo) [757.692130] Starting subtest: torture-bo [757.694347] Starting dynamic subtest: pipe-A [764.206323] Dynamic subtest pipe-A: SUCCESS (6.509s) [764.217983] Starting dynamic subtest: pipe-B [770.686453] Dynamic subtest pipe-B: SUCCESS (6.477s) [770.698411] Starting dynamic subtest: pipe-C [778.428246] Dynamic subtest pipe-C: SUCCESS (7.740s) [778.438140] Starting dynamic subtest: pipe-D [785.891424] Dynamic subtest pipe-D: SUCCESS (7.458s) [785.904111] Starting dynamic subtest: all-pipes [793.496587] Dynamic subtest all-pipes: SUCCESS (7.603s) [793.498842] Subtest torture-bo: SUCCESS (35.795s) [793.662474] [102/134] (229s left) gem_ctx_shared (q-independent) [793.722179] Starting subtest: Q-independent [793.724823] Starting dynamic subtest: rcs0 [793.787403] Dynamic subtest rcs0: SUCCESS (0.065s) [793.799549] Starting dynamic subtest: vcs0 [793.826393] Dynamic subtest vcs0: SUCCESS (0.038s) [793.836427] Starting dynamic subtest: vcs1 [793.863355] Dynamic subtest vcs1: SUCCESS (0.036s) [793.873330] Starting dynamic subtest: vecs0 [793.896868] Dynamic subtest vecs0: SUCCESS (0.033s) [793.906440] Starting dynamic subtest: ccs0 [793.947382] Dynamic subtest ccs0: SUCCESS (0.050s) [793.950150] Subtest Q-independent: SUCCESS (0.226s) [795.686036] [103/134] (227s left) gem_exec_fence (syncobj-timeline-invalid-wait) [796.259362] Starting subtest: syncobj-timeline-invalid-wait [796.266336] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.007s) [797.708659] [104/134] (225s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [797.779180] Starting subtest: y-tiled-ccs-to-x-tiled [797.784698] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [797.980796] [105/134] (225s left) drm_read (short-buffer-wakeup) [798.140349] Starting subtest: short-buffer-wakeup [830.366770] Subtest short-buffer-wakeup: SUCCESS (32.217s) [830.521165] [106/134] (193s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [830.611001] Starting subtest: plane-use-after-nonblocking-unbind-fencing [830.613299] Starting dynamic subtest: pipe-A-eDP-1 [830.672717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s) [830.970359] Starting dynamic subtest: pipe-B-eDP-1 [831.798190] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.838s) [832.088683] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.478s) [832.981149] [107/134] (190s left) syncobj_timeline (device-submit-unordered) [833.035585] Starting subtest: device-submit-unordered [833.038404] Subtest device-submit-unordered: SUCCESS (0.000s) [833.147059] [108/134] (190s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [833.228789] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [833.231275] Starting dynamic subtest: pipe-A-eDP-1 [833.512782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.248s) [833.523692] Starting dynamic subtest: pipe-B-eDP-1 [834.748978] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s) [834.759971] Starting dynamic subtest: pipe-C-eDP-1 [835.959265] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s) [835.970421] Starting dynamic subtest: pipe-D-eDP-1 [837.189240] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s) [837.192065] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.927s) [838.402985] [109/134] (185s left) kms_pipe_crc_basic (nonblocking-crc) [838.506154] Starting subtest: nonblocking-crc [838.508860] Starting dynamic subtest: pipe-A-eDP-1 [839.257161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s) [839.268355] Starting dynamic subtest: pipe-B-eDP-1 [840.725185] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.467s) [840.735909] Starting dynamic subtest: pipe-C-eDP-1 [842.082199] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s) [842.094437] Starting dynamic subtest: pipe-D-eDP-1 [843.420431] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s) [843.422766] Subtest nonblocking-crc: SUCCESS (4.916s) [844.231483] [110/134] (179s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [844.336451] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [844.341845] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [844.459604] [111/134] (179s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [844.565762] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [844.570547] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [844.692207] [112/134] (179s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [844.780912] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [844.807212] Starting dynamic subtest: pipe-A-plane-0 [844.812500] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [844.823230] Starting dynamic subtest: pipe-A-plane-3 [844.828173] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [844.839926] Starting dynamic subtest: pipe-A-plane-5 [844.844742] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [845.910413] Starting dynamic subtest: pipe-B-plane-0 [845.916146] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [845.927764] Starting dynamic subtest: pipe-B-plane-3 [845.933150] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [845.942439] Starting dynamic subtest: pipe-B-plane-5 [845.948319] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [846.216114] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (1.434s) [847.091910] [113/134] (176s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [847.188145] Starting subtest: plane-downscale-factor-0-5-with-rotation [847.191183] Starting dynamic subtest: pipe-A [847.206846] Dynamic subtest pipe-A: SKIP (0.016s) [847.228416] Starting dynamic subtest: pipe-B [847.238421] Dynamic subtest pipe-B: SKIP (0.030s) [847.250406] Starting dynamic subtest: pipe-C [847.272211] Dynamic subtest pipe-C: SKIP (0.035s) [847.281419] Starting dynamic subtest: pipe-D [847.305289] Dynamic subtest pipe-D: SKIP (0.032s) [847.310421] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.117s) [847.439496] [114/134] (176s left) perf_pmu (busy-hang) [847.482490] Starting subtest: busy-hang [847.485116] Starting dynamic subtest: rcs0 [848.750700] Dynamic subtest rcs0: SUCCESS (1.271s) [848.763056] Starting dynamic subtest: bcs0 [849.989683] Dynamic subtest bcs0: SUCCESS (1.238s) [850.002423] Starting dynamic subtest: vcs0 [852.075682] Dynamic subtest vcs0: SUCCESS (2.067s) [852.088103] Starting dynamic subtest: vcs1 [854.109098] Dynamic subtest vcs1: SUCCESS (2.045s) [854.120272] Starting dynamic subtest: vecs0 [856.091931] Dynamic subtest vecs0: SUCCESS (1.985s) [856.105022] Starting dynamic subtest: ccs0 [857.343458] Dynamic subtest ccs0: SUCCESS (1.246s) [857.346292] Subtest busy-hang: SUCCESS (9.863s) [857.471899] [115/134] (166s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [857.597092] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [857.599134] Starting dynamic subtest: pipe-A-eDP-1 [858.476015] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s) [858.488045] Starting dynamic subtest: pipe-B-eDP-1 [860.150366] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.668s) [860.162966] Starting dynamic subtest: pipe-C-eDP-1 [861.633106] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.481s) [861.643885] Starting dynamic subtest: pipe-D-eDP-1 [863.178702] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.546s) [863.181220] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.576s) [864.361935] [116/134] (159s left) kms_cursor_crc (cursor-offscreen-128x42) [864.620258] Starting subtest: cursor-offscreen-128x42 [864.665835] Subtest cursor-offscreen-128x42: SKIP (0.042s) [864.902155] [117/134] (159s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [865.003298] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [865.006095] Starting dynamic subtest: pipe-A [865.026209] Dynamic subtest pipe-A: SKIP (0.018s) [865.036168] Starting dynamic subtest: pipe-B [865.068613] Dynamic subtest pipe-B: SKIP (0.042s) [865.078917] Starting dynamic subtest: pipe-C [865.102149] Dynamic subtest pipe-C: SKIP (0.032s) [865.111567] Starting dynamic subtest: pipe-D [865.135662] Dynamic subtest pipe-D: SKIP (0.033s) [865.140249] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.129s) [865.263831] [118/134] (158s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [865.373835] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [866.431937] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.057s) [866.587785] [119/134] (157s left) syncobj_basic (bad-pad-handle-to-fd) [866.649463] Starting subtest: bad-pad-handle-to-fd [866.652369] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [866.749169] [120/134] (157s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [866.864582] Starting subtest: cursorA-vs-flipB-atomic-transitions [866.868161] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [867.021717] [121/134] (157s left) kms_frontbuffer_tracking (psr-2p-rte) [867.121278] Starting subtest: psr-2p-rte [867.125736] Subtest psr-2p-rte: SKIP (0.000s) [867.245171] [122/134] (157s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [867.355281] Starting subtest: psr-shrfb-scaledprimary [873.084275] Subtest psr-shrfb-scaledprimary: SUCCESS (5.731s) [873.222499] [123/134] (151s left) gen7_exec_parse (cmd-crossing-page) [873.285257] Subtest cmd-crossing-page: SKIP (0.000s) [873.371289] [124/134] (151s left) kms_frontbuffer_tracking (fbc-1p-rte) [873.463284] Starting subtest: fbc-1p-rte [878.916125] Subtest fbc-1p-rte: SUCCESS (5.458s) [880.122266] [125/134] (144s left) gem_mmap_wc (write) [880.187017] Subtest write: SKIP (0.000s) [880.261882] [126/134] (144s left) kms_busy (extended-modeset-hang-newfb) [880.372180] Starting subtest: extended-modeset-hang-newfb [880.374432] Starting dynamic subtest: pipe-A [915.318655] Dynamic subtest pipe-A: SUCCESS (34.944s) [915.327925] Starting dynamic subtest: pipe-D [935.522410] Dynamic subtest pipe-D: SUCCESS (20.198s) [935.524937] Subtest extended-modeset-hang-newfb: SUCCESS (55.147s) [936.370846] [127/134] ( 88s left) i915_pm_rpm (gem-evict-pwrite) [937.935330] Starting subtest: gem-evict-pwrite [937.940828] Subtest gem-evict-pwrite: SKIP (0.000s) [938.681159] [128/134] ( 85s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [938.784407] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [938.787164] Starting dynamic subtest: pipe-A-eDP-1 [938.813616] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [938.829441] Starting dynamic subtest: pipe-B-eDP-1 [938.856010] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [938.865827] Starting dynamic subtest: pipe-C-eDP-1 [938.891120] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [938.900126] Starting dynamic subtest: pipe-D-eDP-1 [938.925632] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [938.930700] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s) [941.030813] [129/134] ( 83s left) i915_suspend (basic-s2idle-without-i915) [941.076149] Starting subtest: basic-s2idle-without-i915 [960.593365] Subtest basic-s2idle-without-i915: SUCCESS (4.352s) [960.723220] [130/134] ( 64s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [960.825834] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [960.828142] Starting dynamic subtest: pipe-A-default-mode [963.544435] Dynamic subtest pipe-A-default-mode: SUCCESS (2.724s) [963.546740] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.726s) [964.393497] [131/134] ( 60s left) kms_big_fb (4-tiled-addfb) [964.503386] Starting subtest: 4-tiled-addfb [964.505212] Subtest 4-tiled-addfb: SUCCESS (0.000s) [964.633108] [132/134] ( 60s left) kms_setmode (basic-clone-single-crtc) [964.696940] Starting subtest: basic-clone-single-crtc [964.703332] Subtest basic-clone-single-crtc: SKIP (0.000s) [964.820687] [133/134] ( 60s left) gem_exec_balancer (full-late-pulse) [964.892331] Starting subtest: full-late-pulse [969.642936] Subtest full-late-pulse: SUCCESS (4.755s) [969.993383] [134/134] ( 54s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [970.107506] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [970.111424] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [970.224569] 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.