[64.089440] Initializing watchdogs [64.089507] /dev/watchdog0 [64.109126] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [64.119869] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [64.123530] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [64.125478] [001/130] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [64.311775] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [64.313418] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [64.500246] [002/130] (960s left) gem_exec_schedule (out-order) [64.591791] Starting subtest: out-order [64.592686] Starting dynamic subtest: rcs0 [64.883138] Dynamic subtest rcs0: SUCCESS (0.291s) [64.892089] Starting dynamic subtest: bcs0 [65.089216] Dynamic subtest bcs0: SUCCESS (0.205s) [65.097257] Starting dynamic subtest: vcs0 [65.298159] Dynamic subtest vcs0: SUCCESS (0.209s) [65.306226] Starting dynamic subtest: vcs1 [65.509392] Dynamic subtest vcs1: SUCCESS (0.211s) [65.517386] Starting dynamic subtest: vecs0 [65.721562] Dynamic subtest vecs0: SUCCESS (0.212s) [65.729408] Starting dynamic subtest: vecs1 [65.953911] Dynamic subtest vecs1: SUCCESS (0.232s) [65.963234] Starting dynamic subtest: ccs0 [66.177370] Dynamic subtest ccs0: SUCCESS (0.223s) [66.178608] Subtest out-order: SUCCESS (1.585s) [66.618651] [003/130] (958s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [66.828014] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s) [66.894845] [004/130] (957s left) kms_pipe_crc_basic (suspend-read-crc) [67.282165] Starting subtest: suspend-read-crc [67.284455] Starting dynamic subtest: pipe-A-DP-3 [87.682275] Dynamic subtest pipe-A-DP-3: SUCCESS (5.103s) [87.692767] Starting dynamic subtest: pipe-B-DP-3 [107.777009] Dynamic subtest pipe-B-DP-3: SUCCESS (4.522s) [107.789356] Starting dynamic subtest: pipe-C-DP-3 [127.995444] Dynamic subtest pipe-C-DP-3: SUCCESS (4.564s) [128.008017] Starting dynamic subtest: pipe-D-DP-3 [148.229461] Dynamic subtest pipe-D-DP-3: SUCCESS (4.544s) [148.230287] Subtest suspend-read-crc: SUCCESS (18.738s) [148.559621] [005/130] (876s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [148.749532] Starting subtest: fbcpsr-2p-rte [148.751900] Subtest fbcpsr-2p-rte: SKIP (0.000s) [148.934420] [006/130] (876s left) kms_hdr (static-toggle) [149.110222] Starting subtest: static-toggle [149.618995] Starting dynamic subtest: pipe-A-DP-3 [150.741642] Dynamic subtest pipe-A-DP-3: SUCCESS (1.122s) [150.742943] Subtest static-toggle: SUCCESS (1.632s) [151.129703] [007/130] (873s left) gem_userptr_blits (sync-unmap-after-close) [151.219261] Starting subtest: sync-unmap-after-close [151.238604] Subtest sync-unmap-after-close: SUCCESS (0.020s) [151.465278] [008/130] (873s left) kms_selftest (drm_cmdline_parser) [151.508494] Starting subtest: drm_cmdline_parser [151.525551] Starting dynamic subtest: drm_test_cmdline_force_d_only [151.595887] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.071s) [151.609854] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [151.695771] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.099s) [151.735514] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [151.783362] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.087s) [151.816570] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [151.896108] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.111s) [151.934912] Starting dynamic subtest: drm_test_cmdline_force_e_only [151.980515] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.085s) [152.018205] Starting dynamic subtest: drm_test_cmdline_res [152.048630] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.067s) [152.068547] Starting dynamic subtest: drm_test_cmdline_res_vesa [152.123034] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.072s) [152.137752] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [152.205796] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.081s) [152.244934] Starting dynamic subtest: drm_test_cmdline_res_rblank [152.295135] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.089s) [152.332959] Starting dynamic subtest: drm_test_cmdline_res_bpp [152.382415] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.086s) [152.424038] Starting dynamic subtest: drm_test_cmdline_res_refresh [152.481965] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.098s) [152.521293] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [152.565627] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.083s) [152.603406] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [152.673244] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.105s) [152.712359] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [152.754090] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.081s) [152.791058] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [152.838996] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.083s) [152.877506] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [152.917950] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.079s) [152.948908] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [153.006182] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.088s) [153.041119] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [153.085208] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.078s) [153.122780] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [153.172021] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.086s) [153.209891] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [153.275185] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.101s) [153.312484] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [153.372250] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.096s) [153.409406] Starting dynamic subtest: drm_test_cmdline_name [153.450067] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.077s) [153.481587] Starting dynamic subtest: drm_test_cmdline_name_bpp [153.543062] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.092s) [153.582677] Starting dynamic subtest: drm_test_cmdline_name_option [153.639292] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.096s) [153.679131] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [153.725326] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.086s) [153.735756] Starting dynamic subtest: drm_test_cmdline_rotate_0 [153.808076] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.080s) [153.845586] Starting dynamic subtest: drm_test_cmdline_rotate_90 [153.894192] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.087s) [153.905014] Starting dynamic subtest: drm_test_cmdline_rotate_180 [153.980424] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.085s) [154.020308] Starting dynamic subtest: drm_test_cmdline_rotate_270 [154.059016] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.078s) [154.091848] Starting dynamic subtest: drm_test_cmdline_hmirror [154.146147] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.084s) [154.180604] Starting dynamic subtest: drm_test_cmdline_vmirror [154.228750] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.082s) [154.259436] Starting dynamic subtest: drm_test_cmdline_margin_options [154.337973] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.108s) [154.376280] Starting dynamic subtest: drm_test_cmdline_multiple_options [154.417252] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.079s) [154.442911] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [154.503203] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.085s) [154.517955] Starting dynamic subtest: drm_test_cmdline_extra_and_option [154.576060] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.073s) [154.605123] Starting dynamic subtest: drm_test_cmdline_freestanding_options [154.663293] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.087s) [154.704323] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [154.744271] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.080s) [154.783009] Starting dynamic subtest: drm_test_cmdline_panel_orientation [154.873152] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.126s) [154.910922] Starting dynamic subtest: drm_test_cmdline_invalid [154.976148] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.103s) [155.002435] Starting dynamic subtest: drm_test_cmdline_tv_options [155.074212] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.098s) [155.075033] Subtest drm_cmdline_parser: SUCCESS (3.565s) [155.314977] [009/130] (869s left) gem_exec_gttfill (engines) [155.393701] Starting subtest: engines [155.394617] Starting dynamic subtest: rcs0 [181.115832] Dynamic subtest rcs0: SUCCESS (25.722s) [181.126484] Starting dynamic subtest: bcs0 [207.077157] Dynamic subtest bcs0: SUCCESS (25.964s) [207.088869] Starting dynamic subtest: vcs0 [233.054739] Dynamic subtest vcs0: SUCCESS (25.978s) [233.065333] Starting dynamic subtest: vcs1 [258.961216] Dynamic subtest vcs1: SUCCESS (25.906s) [258.973120] Starting dynamic subtest: vecs0 [284.938943] Dynamic subtest vecs0: SUCCESS (25.977s) [284.949687] Starting dynamic subtest: vecs1 [310.810857] Dynamic subtest vecs1: SUCCESS (25.871s) [310.821697] Starting dynamic subtest: ccs0 [336.864721] Dynamic subtest ccs0: SUCCESS (26.054s) [336.865678] Subtest engines: SUCCESS (181.474s) [337.120258] [010/130] (688s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [337.338644] Starting subtest: fbc-rgb101010-draw-blt [340.191848] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.854s) [340.383329] [011/130] (684s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [340.580828] Starting subtest: yf-tiled-8bpp-rotate-270 [340.582555] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [340.763466] [012/130] (684s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [340.945730] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [340.947359] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [341.133606] [013/130] (684s left) i915_getparams_basic (basic-eu-total) [341.210173] Starting subtest: basic-eu-total [341.212184] Subtest basic-eu-total: SUCCESS (0.000s) [341.407252] [014/130] (684s left) prime_vgem (fence-wait) [341.595138] Starting subtest: fence-wait [341.596060] Starting dynamic subtest: rcs0 [342.662431] Dynamic subtest rcs0: SUCCESS (1.066s) [342.677038] Starting dynamic subtest: bcs0 [343.742088] Dynamic subtest bcs0: SUCCESS (1.078s) [343.753232] Starting dynamic subtest: vcs0 [344.788184] Dynamic subtest vcs0: SUCCESS (1.045s) [344.799386] Starting dynamic subtest: vcs1 [345.830439] Dynamic subtest vcs1: SUCCESS (1.041s) [345.871529] Starting dynamic subtest: vecs0 [346.876445] Dynamic subtest vecs0: SUCCESS (1.045s) [346.891760] Starting dynamic subtest: vecs1 [347.918998] Dynamic subtest vecs1: SUCCESS (1.041s) [347.934497] Starting dynamic subtest: ccs0 [348.963519] Dynamic subtest ccs0: SUCCESS (1.043s) [348.965373] Subtest fence-wait: SUCCESS (7.368s) [349.151325] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true [349.153837] [015/130] (676s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [349.344806] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [349.346488] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [349.558457] [016/130] (676s left) gem_ctx_shared (exec-shared-gtt) [349.643871] Starting subtest: exec-shared-gtt [349.644795] Starting dynamic subtest: rcs0 [349.654816] Dynamic subtest rcs0: SUCCESS (0.011s) [349.667474] Starting dynamic subtest: bcs0 [349.668378] Dynamic subtest bcs0: SUCCESS (0.009s) [349.679926] Starting dynamic subtest: vcs0 [349.680805] Dynamic subtest vcs0: SUCCESS (0.007s) [349.692175] Starting dynamic subtest: vcs1 [349.693111] Dynamic subtest vcs1: SUCCESS (0.007s) [349.705091] Starting dynamic subtest: vecs0 [349.706012] Dynamic subtest vecs0: SUCCESS (0.007s) [349.717330] Starting dynamic subtest: vecs1 [349.718500] Dynamic subtest vecs1: SUCCESS (0.006s) [349.730438] Starting dynamic subtest: ccs0 [349.731429] Dynamic subtest ccs0: SUCCESS (0.007s) [349.732290] Subtest exec-shared-gtt: SUCCESS (0.056s) [350.000728] [017/130] (675s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [350.195930] Starting subtest: modeset-atomic-cursor-hotspot [350.197735] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [350.360865] [018/130] (675s left) kms_plane_cursor (viewport) [350.549681] Starting subtest: viewport [350.551518] Starting dynamic subtest: pipe-A-DP-3-size-64 [353.791994] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.241s) [353.870376] Starting dynamic subtest: pipe-A-DP-3-size-128 [357.059048] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.200s) [357.137043] Starting dynamic subtest: pipe-A-DP-3-size-256 [360.358193] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.233s) [360.538033] Starting dynamic subtest: pipe-B-DP-3-size-64 [363.772293] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.251s) [363.832831] Starting dynamic subtest: pipe-B-DP-3-size-128 [367.104604] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.283s) [367.197813] Starting dynamic subtest: pipe-B-DP-3-size-256 [370.422496] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.266s) [370.544488] Starting dynamic subtest: pipe-C-DP-3-size-64 [373.795968] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.264s) [373.867459] Starting dynamic subtest: pipe-C-DP-3-size-128 [377.061613] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.216s) [377.126116] Starting dynamic subtest: pipe-C-DP-3-size-256 [380.329942] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.217s) [380.457200] Starting dynamic subtest: pipe-D-DP-3-size-64 [383.727005] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.285s) [383.787930] Starting dynamic subtest: pipe-D-DP-3-size-128 [387.042718] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.267s) [387.120876] Starting dynamic subtest: pipe-D-DP-3-size-256 [390.360676] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.267s) [390.485256] Subtest viewport: SUCCESS (39.934s) [390.785141] [019/130] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [390.977140] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [390.978766] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [391.170140] [020/130] (634s left) kms_psr2_su (page_flip-xrgb8888) [391.249364] Subtest page_flip-XRGB8888: SKIP (0.000s) [391.318150] [021/130] (634s left) kms_big_fb (4-tiled-32bpp-rotate-90) [391.512506] Starting subtest: 4-tiled-32bpp-rotate-90 [391.569719] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.057s) [391.800673] [022/130] (634s left) kms_vblank (ts-continuation-dpms-rpm) [391.985828] Starting subtest: ts-continuation-dpms-rpm [391.987774] Starting dynamic subtest: pipe-A-DP-3 [393.905426] Dynamic subtest pipe-A-DP-3: SUCCESS (1.918s) [393.933334] Starting dynamic subtest: pipe-D-DP-3 [394.746298] Dynamic subtest pipe-D-DP-3: SUCCESS (0.833s) [394.747296] Subtest ts-continuation-dpms-rpm: SUCCESS (2.760s) [395.017934] [023/130] (631s left) template (a) [395.095496] Starting subtest: A [395.096514] Subtest A: SUCCESS (0.000s) [395.301129] [024/130] (631s left) i915_pm_rc6_residency (rc6-accuracy) [395.375703] Starting subtest: rc6-accuracy [395.376621] Starting dynamic subtest: gt0 [398.590864] Dynamic subtest gt0: FAIL (3.194s) [398.591931] Subtest rc6-accuracy: FAIL (3.195s) [398.717609] [025/130] (627s left) gem_exec_balancer (parallel) [399.095459] Starting subtest: parallel [400.702325] Subtest parallel: SUCCESS (1.607s) [400.877705] [026/130] (625s left) kms_content_protection (atomic) [401.125424] Starting subtest: atomic [401.153210] Starting dynamic subtest: pipe-A-DP-3 [522.191226] Dynamic subtest pipe-A-DP-3: FAIL (120.863s) [522.192035] Subtest atomic: FAIL (120.972s) [522.413181] [027/130] (504s left) kms_cursor_legacy (cursor-vs-flip-atomic) [522.598492] Starting subtest: cursor-vs-flip-atomic [552.886049] Subtest cursor-vs-flip-atomic: SUCCESS (30.288s) [553.191039] [028/130] (473s left) perf_pmu (enable-race) [553.259127] Starting subtest: enable-race [553.260028] Starting dynamic subtest: rcs0 [566.014942] Dynamic subtest rcs0: SUCCESS (12.755s) [566.027233] Starting dynamic subtest: bcs0 [578.764913] Dynamic subtest bcs0: SUCCESS (12.749s) [578.776887] Starting dynamic subtest: vcs0 [591.504521] Dynamic subtest vcs0: SUCCESS (12.739s) [591.517566] Starting dynamic subtest: vcs1 [604.241560] Dynamic subtest vcs1: SUCCESS (12.736s) [604.253691] Starting dynamic subtest: vecs0 [616.980725] Dynamic subtest vecs0: SUCCESS (12.738s) [616.993021] Starting dynamic subtest: vecs1 [629.719731] Dynamic subtest vecs1: SUCCESS (12.738s) [629.736099] Starting dynamic subtest: ccs0 [642.455511] Dynamic subtest ccs0: SUCCESS (12.735s) [642.456473] Subtest enable-race: SUCCESS (89.196s) [642.635156] [029/130] (384s left) vgem_basic (create) [642.700890] Starting subtest: create [642.701776] Subtest create: SUCCESS (0.000s) [642.862172] [030/130] (383s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [643.046860] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [643.049041] Starting dynamic subtest: pipe-A-DP-3 [643.070242] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [643.082766] Starting dynamic subtest: pipe-B-DP-3 [643.104340] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [643.116092] Starting dynamic subtest: pipe-C-DP-3 [643.141301] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [643.153850] Starting dynamic subtest: pipe-D-DP-3 [643.176179] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [643.178071] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.013s) [643.529691] [031/130] (383s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [643.726194] Starting subtest: psr-rgb101010-draw-mmap-gtt [643.727781] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [643.928775] [032/130] (383s left) i915_query (query-regions-unallocated) [644.011532] Starting subtest: query-regions-unallocated [645.109877] Subtest query-regions-unallocated: SUCCESS (1.098s) [645.294916] [033/130] (381s left) kms_cursor_crc (cursor-rapid-movement-max-size) [645.793085] Starting subtest: cursor-rapid-movement-max-size [645.796328] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [646.027744] [034/130] (381s left) api_intel_bb (intel-bb-blit-x) [646.113824] Starting subtest: intel-bb-blit-x [646.790406] Subtest intel-bb-blit-x: SUCCESS (0.676s) [646.975025] [035/130] (380s left) kms_addfb_basic (bo-too-small-due-to-tiling) [647.159027] Starting subtest: bo-too-small-due-to-tiling [647.160736] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [647.360859] [036/130] (379s left) kms_hdr (bpc-switch-dpms) [647.548924] Starting subtest: bpc-switch-dpms [650.808328] Starting dynamic subtest: pipe-A-DP-3 [652.089671] Dynamic subtest pipe-A-DP-3: SUCCESS (1.281s) [652.090870] Subtest bpc-switch-dpms: SUCCESS (4.541s) [652.447621] [037/130] (374s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [652.635700] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [652.651743] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s) [652.811246] [038/130] (374s left) syncobj_wait (invalid-signal-illegal-handle) [652.892852] Starting subtest: invalid-signal-illegal-handle [652.893781] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [653.124730] [039/130] (374s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [653.208001] Starting subtest: legacy-engines-hostile-preempt [653.208931] Starting dynamic subtest: render [653.311827] Dynamic subtest render: SUCCESS (0.103s) [653.329848] Starting dynamic subtest: bsd1 [653.368979] Dynamic subtest bsd1: SUCCESS (0.055s) [653.385419] Starting dynamic subtest: bsd2 [653.416634] Dynamic subtest bsd2: SUCCESS (0.045s) [653.435937] Starting dynamic subtest: blt [653.464887] Dynamic subtest blt: SUCCESS (0.047s) [653.492435] Starting dynamic subtest: vebox [653.523920] Dynamic subtest vebox: SUCCESS (0.057s) [653.525149] Subtest legacy-engines-hostile-preempt: SUCCESS (0.317s) [653.745178] [040/130] (373s left) kms_pm_rpm (pc8-residency) [655.252555] Starting subtest: pc8-residency [655.256021] Subtest pc8-residency: SKIP (0.000s) [655.724072] [041/130] (372s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [655.918282] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [655.919949] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [656.108062] [042/130] (371s left) kms_sequence (get-busy) [656.291955] Starting subtest: get-busy [656.294395] Starting dynamic subtest: pipe-A-DP-3 [658.879752] Dynamic subtest pipe-A-DP-3: SUCCESS (2.586s) [658.892135] Starting dynamic subtest: pipe-B-DP-3 [661.359496] Dynamic subtest pipe-B-DP-3: SUCCESS (2.479s) [661.372934] Starting dynamic subtest: pipe-C-DP-3 [663.839723] Dynamic subtest pipe-C-DP-3: SUCCESS (2.478s) [663.852161] Starting dynamic subtest: pipe-D-DP-3 [666.310737] Dynamic subtest pipe-D-DP-3: SUCCESS (2.469s) [666.311637] Subtest get-busy: SUCCESS (10.018s) [666.598882] [043/130] (361s left) gen9_exec_parse (batch-without-end) [666.683142] Subtest batch-without-end: SKIP (0.000s) [666.781510] [044/130] (361s left) gem_exec_whisper (basic-queues-forked-all) [666.871904] Starting subtest: basic-queues-forked-all [688.897714] Subtest basic-queues-forked-all: SUCCESS (22.024s) [689.148349] [045/130] (338s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [689.332265] Starting subtest: plane-upscale-factor-0-25-with-modifiers [689.333123] Starting dynamic subtest: pipe-A [689.901507] Dynamic subtest pipe-A: SUCCESS (0.569s) [689.933595] Starting dynamic subtest: pipe-B [690.547755] Dynamic subtest pipe-B: SUCCESS (0.644s) [690.576577] Starting dynamic subtest: pipe-C [691.193894] Dynamic subtest pipe-C: SUCCESS (0.644s) [691.225649] Starting dynamic subtest: pipe-D [691.840625] Dynamic subtest pipe-D: SUCCESS (0.645s) [691.841601] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.509s) [692.168612] [046/130] (335s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [692.357745] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [692.358606] Starting dynamic subtest: pipe-A-DP-3 [692.366713] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [692.379132] Starting dynamic subtest: pipe-B-DP-3 [692.387289] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [692.399580] Starting dynamic subtest: pipe-C-DP-3 [692.407601] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [692.419843] Starting dynamic subtest: pipe-D-DP-3 [692.429895] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [692.431846] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s) [692.844088] [047/130] (335s left) kms_psr (pr-cursor-plane-onoff) [693.030925] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [693.115837] [048/130] (335s left) kms_cursor_crc (cursor-alpha-transparent) [693.302617] Starting subtest: cursor-alpha-transparent [693.303521] Starting dynamic subtest: pipe-A-DP-3 [693.891067] Dynamic subtest pipe-A-DP-3: SUCCESS (0.587s) [693.917507] Starting dynamic subtest: pipe-D-DP-3 [694.427756] Dynamic subtest pipe-D-DP-3: SUCCESS (0.533s) [694.428735] Subtest cursor-alpha-transparent: SUCCESS (1.126s) [695.076043] [049/130] (333s left) gem_exec_suspend (basic-s3) [695.167935] Starting subtest: basic-S3 [695.168803] Starting dynamic subtest: smem [718.030667] Dynamic subtest smem: SUCCESS (7.436s) [718.046326] Starting dynamic subtest: lmem0 [740.204925] Dynamic subtest lmem0: SUCCESS (7.251s) [740.205785] Subtest basic-S3: SUCCESS (14.689s) [740.479712] [050/130] (287s left) kms_properties (colorop-properties-atomic) [740.673840] Starting subtest: colorop-properties-atomic [740.674772] Starting dynamic subtest: pipe-A-DP-3 [740.819960] Dynamic subtest pipe-A-DP-3: SUCCESS (0.144s) [740.834226] Starting dynamic subtest: pipe-B-DP-3 [741.002290] Dynamic subtest pipe-B-DP-3: SUCCESS (0.181s) [741.015275] Starting dynamic subtest: pipe-C-DP-3 [741.185225] Dynamic subtest pipe-C-DP-3: SUCCESS (0.181s) [741.198122] Starting dynamic subtest: pipe-D-DP-3 [741.368289] Dynamic subtest pipe-D-DP-3: SUCCESS (0.181s) [741.369295] Subtest colorop-properties-atomic: SUCCESS (0.695s) [741.697641] [051/130] (286s left) gem_ctx_isolation (clean) [741.792811] Starting subtest: clean [741.793776] Starting dynamic subtest: rcs0 [741.888115] Dynamic subtest rcs0: SUCCESS (0.096s) [741.902666] Starting dynamic subtest: bcs0 [741.996800] Dynamic subtest bcs0: SUCCESS (0.107s) [742.011735] Starting dynamic subtest: vcs0 [742.106610] Dynamic subtest vcs0: SUCCESS (0.109s) [742.121181] Starting dynamic subtest: vcs1 [742.210753] Dynamic subtest vcs1: SUCCESS (0.103s) [742.225296] Starting dynamic subtest: vecs0 [742.337843] Dynamic subtest vecs0: SUCCESS (0.126s) [742.352146] Starting dynamic subtest: vecs1 [742.446035] Dynamic subtest vecs1: SUCCESS (0.107s) [742.461373] Starting dynamic subtest: ccs0 [742.552747] Dynamic subtest ccs0: SUCCESS (0.106s) [742.553581] Subtest clean: SUCCESS (0.762s) [742.867937] [052/130] (285s left) kms_flip (plain-flip-ts-check) [743.054793] Starting subtest: plain-flip-ts-check [743.059631] Starting dynamic subtest: A-DP3 [751.178274] Dynamic subtest A-DP3: SUCCESS (8.118s) [751.200225] Starting dynamic subtest: B-DP3 [759.221423] Dynamic subtest B-DP3: SUCCESS (8.041s) [759.236520] Starting dynamic subtest: C-DP3 [767.278321] Dynamic subtest C-DP3: SUCCESS (8.055s) [767.293494] Starting dynamic subtest: D-DP3 [775.347421] Dynamic subtest D-DP3: SUCCESS (8.068s) [775.349683] Subtest plain-flip-ts-check: SUCCESS (32.295s) [775.698962] [053/130] (252s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [775.890409] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [775.892238] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [776.107620] [054/130] (252s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [776.297668] Starting subtest: fbc-2p-primscrn-spr-indfb-move [776.299405] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [776.477414] [055/130] (252s left) gem_wait (write-wait) [776.577807] Starting subtest: write-wait [776.578745] Starting dynamic subtest: all-engines [777.723633] Dynamic subtest all-engines: SUCCESS (1.145s) [777.739691] Starting dynamic subtest: rcs0 [778.783884] Dynamic subtest rcs0: SUCCESS (1.059s) [778.800649] Starting dynamic subtest: bcs0 [779.843984] Dynamic subtest bcs0: SUCCESS (1.057s) [779.865401] Starting dynamic subtest: vcs0 [780.907859] Dynamic subtest vcs0: SUCCESS (1.059s) [780.929370] Starting dynamic subtest: vcs1 [781.971839] Dynamic subtest vcs1: SUCCESS (1.059s) [781.994408] Starting dynamic subtest: vecs0 [783.036744] Dynamic subtest vecs0: SUCCESS (1.060s) [783.058531] Starting dynamic subtest: vecs1 [784.099802] Dynamic subtest vecs1: SUCCESS (1.058s) [784.121340] Starting dynamic subtest: ccs0 [785.163810] Dynamic subtest ccs0: SUCCESS (1.059s) [785.169482] Subtest write-wait: SUCCESS (8.588s) [785.477435] [056/130] (243s left) perf (short-reads) [785.886832] Starting subtest: short-reads [785.912438] Subtest short-reads: SUCCESS (0.025s) [785.979104] [057/130] (242s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [786.181169] Starting subtest: addfb25-y-tiled-small-legacy [786.182789] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [786.555906] [058/130] (242s left) syncobj_timeline (wait-all-for-submit-complex) [786.804846] Starting subtest: wait-all-for-submit-complex [787.018720] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [787.145312] [059/130] (241s left) gem_exec_capture (userptr) [787.232953] Starting subtest: userptr [788.168764] Subtest userptr: SUCCESS (0.936s) [788.342409] [060/130] (240s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [788.422725] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [788.530055] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s) [788.714210] [061/130] (240s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [788.901641] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [788.902550] Starting dynamic subtest: pipe-A-valid-mode [788.990336] Dynamic subtest pipe-A-valid-mode: SKIP (0.086s) [788.992211] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.088s) [789.244696] [062/130] (240s left) drm_read (empty-nonblock) [789.498662] Starting subtest: empty-nonblock [789.499622] Subtest empty-nonblock: SUCCESS (0.000s) [789.765345] [063/130] (239s left) kms_big_fb (y-tiled-addfb-size-overflow) [789.961418] Starting subtest: y-tiled-addfb-size-overflow [789.963202] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [790.165344] [064/130] (239s left) api_intel_allocator (reopen-fork) [790.239032] Starting subtest: reopen-fork [793.695655] Subtest reopen-fork: SUCCESS (3.458s) [793.850114] [065/130] (235s left) gem_exec_store (pages) [793.936642] Starting subtest: pages [793.937553] Starting dynamic subtest: rcs0 [794.088233] Dynamic subtest rcs0: SUCCESS (0.151s) [794.108665] Starting dynamic subtest: bcs0 [794.207757] Dynamic subtest bcs0: SUCCESS (0.118s) [794.221837] Starting dynamic subtest: vcs0 [794.312037] Dynamic subtest vcs0: SUCCESS (0.103s) [794.325505] Starting dynamic subtest: vcs1 [794.418705] Dynamic subtest vcs1: SUCCESS (0.106s) [794.431986] Starting dynamic subtest: vecs0 [794.518764] Dynamic subtest vecs0: SUCCESS (0.099s) [794.532073] Starting dynamic subtest: vecs1 [794.616433] Dynamic subtest vecs1: SUCCESS (0.097s) [794.629793] Starting dynamic subtest: ccs0 [794.714962] Dynamic subtest ccs0: SUCCESS (0.097s) [794.715914] Subtest pages: SUCCESS (0.779s) [795.033112] [066/130] (234s left) syncobj_wait (multi-wait-all-for-submit-signaled) [795.117765] Starting subtest: multi-wait-all-for-submit-signaled [795.118904] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s) [795.332157] [067/130] (234s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [795.520424] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [795.522374] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [795.732078] [068/130] (234s left) kms_addfb_basic (unused-offsets) [795.808946] Starting subtest: unused-offsets [795.809819] Subtest unused-offsets: SUCCESS (0.000s) [796.113392] [069/130] (233s left) syncobj_timeline (single-wait-all-available-signaled) [796.189665] Starting subtest: single-wait-all-available-signaled [796.190607] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [796.397816] [070/130] (233s left) gem_eio (in-flight-internal-10ms) [796.693971] Starting subtest: in-flight-internal-10ms [798.415625] Subtest in-flight-internal-10ms: SUCCESS (1.722s) [798.713400] [071/130] (231s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [798.910818] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [800.198853] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.287s) [800.432895] [072/130] (229s left) syncobj_basic (bad-destroy-pad) [800.513967] Starting subtest: bad-destroy-pad [800.514964] Subtest bad-destroy-pad: SUCCESS (0.000s) [800.679429] [073/130] (229s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [800.863171] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [800.865517] Starting dynamic subtest: pipe-A-valid-mode [803.481677] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.613s) [803.483421] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.617s) [803.769633] [074/130] (226s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [803.959425] Starting subtest: psr-2p-primscrn-cur-indfb-move [803.961197] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [804.169518] [075/130] (226s left) kms_psr (psr2-sprite-mmap-cpu) [804.357082] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s) [804.413385] [076/130] (226s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [804.603347] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [808.816586] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.214s) [809.086341] [077/130] (221s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [809.278684] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [809.329885] [078/130] (221s left) kms_big_fb (x-tiled-8bpp-rotate-0) [809.526798] Starting subtest: x-tiled-8bpp-rotate-0 [811.151284] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.623s) [811.401687] [079/130] (219s left) perf (gen12-mi-rpc) [811.661737] Starting subtest: gen12-mi-rpc [811.662711] Starting dynamic subtest: rcs0 [811.713118] Dynamic subtest rcs0: SUCCESS (0.051s) [811.713920] Subtest gen12-mi-rpc: SUCCESS (0.052s) [811.765426] [080/130] (218s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs) [811.990786] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs [811.991659] Starting dynamic subtest: pipe-A-DP-3 [812.000001] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [812.013664] Starting dynamic subtest: pipe-B-DP-3 [812.021685] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [812.034719] Starting dynamic subtest: pipe-C-DP-3 [812.042718] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [812.055983] Starting dynamic subtest: pipe-D-DP-3 [812.066290] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [812.068230] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.007s) [812.479916] [081/130] (218s left) kms_joiner (invalid-modeset-big-joiner) [812.669601] Starting subtest: invalid-modeset-big-joiner [812.671311] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [812.826025] [082/130] (218s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [813.008633] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [813.009551] Starting dynamic subtest: pipe-A-valid-mode [814.817008] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.805s) [814.818711] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.809s) [815.137974] [083/130] (215s left) gem_exec_fence (invalid-timeline-fence-array) [815.822822] Starting subtest: invalid-timeline-fence-array [815.835952] Subtest invalid-timeline-fence-array: SUCCESS (0.013s) [816.130314] [084/130] (214s left) kms_chamelium_color (ctm-negative) [816.313239] Subtest ctm-negative: SKIP (0.000s) [816.375271] [085/130] (214s left) gem_exec_flush (basic-wb-prw-default) [816.457656] Subtest basic-wb-prw-default: SKIP (0.000s) [816.544081] [086/130] (214s left) gem_exec_reloc (basic-softpin) [816.628799] Subtest basic-softpin: SKIP (0.000s) [816.713151] [087/130] (214s left) gem_mmap_wc (bad-object) [816.789536] Subtest bad-object: SKIP (0.000s) [816.859314] [088/130] (214s left) gem_mmap_gtt (pf-nonblock) [816.937514] Subtest pf-nonblock: SKIP (0.000s) [817.008968] [089/130] (214s left) kms_chamelium_hpd (dp-hpd-after-suspend) [817.271044] Subtest dp-hpd-after-suspend: SKIP (0.000s) [817.421158] [090/130] (213s left) gem_eio (wait-wedge-immediate) [817.705771] Starting subtest: wait-wedge-immediate [819.466669] Subtest wait-wedge-immediate: SUCCESS (1.762s) [819.753648] [091/130] (211s left) prime_mmap (test_forked_cpu_write) [819.830240] Starting subtest: test_forked_cpu_write [819.831123] Starting dynamic subtest: test_forked_cpu_write-smem [819.839102] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [819.854348] Starting dynamic subtest: test_forked_cpu_write-lmem0 [819.855280] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.008s) [819.856385] Subtest test_forked_cpu_write: SUCCESS (0.019s) [820.053229] [092/130] (211s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [820.246195] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [820.247848] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [820.455428] [093/130] (211s left) kms_hdmi_inject (inject-4k) [820.603879] Starting subtest: inject-4k [820.762788] Subtest inject-4k: SUCCESS (0.160s) [821.132348] [094/130] (210s left) perf_pmu (frequency) [821.201915] Starting subtest: frequency [821.204952] Starting dynamic subtest: gt0 [823.511167] Dynamic subtest gt0: FAIL (2.222s) [823.555845] Starting dynamic subtest: idle-gt0 [823.937166] Dynamic subtest idle-gt0: SUCCESS (0.505s) [823.938202] Subtest frequency: FAIL (2.736s) [824.128280] [095/130] (207s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [824.312073] Starting subtest: plane-scaler-with-clipping-clamping-rotation [824.312886] Starting dynamic subtest: pipe-A [824.711137] Dynamic subtest pipe-A: SUCCESS (0.398s) [824.749480] Starting dynamic subtest: pipe-B [825.188891] Dynamic subtest pipe-B: SUCCESS (0.475s) [825.210666] Starting dynamic subtest: pipe-C [825.652049] Dynamic subtest pipe-C: SUCCESS (0.462s) [825.672815] Starting dynamic subtest: pipe-D [826.114215] Dynamic subtest pipe-D: SUCCESS (0.461s) [826.115557] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.803s) [826.476442] [096/130] (205s left) gem_mmap_gtt (basic-write-read) [826.552618] Subtest basic-write-read: SKIP (0.000s) [826.626918] [097/130] (205s left) gem_softpin (evict-snoop) [826.711920] Starting subtest: evict-snoop [826.713804] Subtest evict-snoop: SKIP (0.000s) [826.882639] [098/130] (205s left) gem_exec_schedule (preempt-user) [826.973809] Starting subtest: preempt-user [826.974766] Starting dynamic subtest: rcs0 [827.044307] Dynamic subtest rcs0: SUCCESS (0.070s) [827.061113] Starting dynamic subtest: bcs0 [827.083338] Dynamic subtest bcs0: SUCCESS (0.038s) [827.099724] Starting dynamic subtest: vcs0 [827.122306] Dynamic subtest vcs0: SUCCESS (0.037s) [827.138306] Starting dynamic subtest: vcs1 [827.158473] Dynamic subtest vcs1: SUCCESS (0.035s) [827.174432] Starting dynamic subtest: vecs0 [827.194184] Dynamic subtest vecs0: SUCCESS (0.035s) [827.210657] Starting dynamic subtest: vecs1 [827.230323] Dynamic subtest vecs1: SUCCESS (0.035s) [827.247150] Starting dynamic subtest: ccs0 [827.266778] Dynamic subtest ccs0: SUCCESS (0.035s) [827.267644] Subtest preempt-user: SUCCESS (0.294s) [827.730237] [099/130] (204s left) kms_cursor_legacy (cursor-vs-flip-legacy) [827.912633] Starting subtest: cursor-vs-flip-legacy [858.172722] Subtest cursor-vs-flip-legacy: SUCCESS (30.257s) [858.458479] [100/130] (173s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [858.647272] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [858.648934] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [858.838467] [101/130] (173s left) gem_create (create-clear) [858.919724] Starting subtest: create-clear [858.921117] Starting dynamic subtest: lmem0 [892.398206] Dynamic subtest lmem0: SUCCESS (33.476s) [892.416375] Starting dynamic subtest: smem0 [926.150511] Dynamic subtest smem0: SUCCESS (33.749s) [926.151397] Subtest create-clear: SUCCESS (67.227s) [926.430721] [102/130] (105s left) kms_flip (absolute-wf_vblank) [926.648722] Starting subtest: absolute-wf_vblank [926.653529] Starting dynamic subtest: A-DP3 [934.462984] Dynamic subtest A-DP3: SUCCESS (7.809s) [934.480719] Starting dynamic subtest: B-DP3 [942.229123] Dynamic subtest B-DP3: SUCCESS (7.764s) [942.245941] Starting dynamic subtest: C-DP3 [950.002147] Dynamic subtest C-DP3: SUCCESS (7.772s) [950.018950] Starting dynamic subtest: D-DP3 [957.775209] Dynamic subtest D-DP3: SUCCESS (7.772s) [957.777596] Subtest absolute-wf_vblank: SUCCESS (31.128s) [958.100148] [103/130] ( 74s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [958.286639] Starting subtest: plane-use-after-nonblocking-unbind [958.287552] Starting dynamic subtest: pipe-A-DP-3 [958.355713] Dynamic subtest pipe-A-DP-3: SUCCESS (0.069s) [958.465332] Starting dynamic subtest: pipe-B-DP-3 [958.651497] Dynamic subtest pipe-B-DP-3: SUCCESS (0.203s) [958.738046] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.452s) [959.040113] [104/130] ( 73s left) gem_workarounds (suspend-resume-fd) [959.136736] Starting subtest: suspend-resume-fd [978.266153] Subtest suspend-resume-fd: SUCCESS (3.869s) [978.432723] [105/130] ( 54s left) kms_psr (fbc-psr-primary-mmap-cpu) [978.617373] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s) [978.677240] [106/130] ( 53s left) gem_exec_capture (capture-recoverable) [978.770085] Starting subtest: capture-recoverable [978.775993] Subtest capture-recoverable: SUCCESS (0.006s) [979.012471] [107/130] ( 53s left) gem_mmap_gtt (big-bo-tiledy) [979.086889] Subtest big-bo-tiledY: SKIP (0.000s) [979.166424] [108/130] ( 53s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [979.350498] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [979.352726] Starting dynamic subtest: pipe-A-DP-3 [979.356092] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [979.370422] Starting dynamic subtest: pipe-B-DP-3 [979.373800] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [979.389194] Starting dynamic subtest: pipe-C-DP-3 [979.392625] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [979.406733] Starting dynamic subtest: pipe-D-DP-3 [979.410619] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [979.412502] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s) [979.808174] [109/130] ( 52s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [979.893073] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [979.894017] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s) [980.063370] [110/130] ( 52s left) kms_big_fb (linear-8bpp-rotate-90) [980.256587] Starting subtest: linear-8bpp-rotate-90 [980.307215] Subtest linear-8bpp-rotate-90: SKIP (0.050s) [980.540456] [111/130] ( 52s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [980.624854] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [980.704391] [112/130] ( 52s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [980.888067] Starting subtest: basic-flip-before-cursor-legacy [981.913225] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.026s) [982.215465] [113/130] ( 50s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [982.403603] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [982.405218] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [982.601532] [114/130] ( 50s left) gem_render_copy (yf-tiled) [982.687201] Starting subtest: yf-tiled [982.689264] Subtest yf-tiled: SKIP (0.000s) [982.933014] [115/130] ( 50s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [983.009059] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [983.076989] [116/130] ( 50s left) gem_softpin (safe-alignment) [983.178067] Starting subtest: safe-alignment [983.234227] Subtest safe-alignment: SUCCESS (0.056s) [983.476966] [117/130] ( 49s left) kms_dp_link_training (uhbr-sst) [983.663914] Starting subtest: uhbr-sst [983.665659] Subtest uhbr-sst: SKIP (0.000s) [983.836118] [118/130] ( 49s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [983.918173] Starting subtest: y-tiled-to-vebox-yf-tiled [983.919982] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [984.211198] [119/130] ( 49s left) perf (polling) [984.445311] Starting subtest: polling [984.446205] Starting dynamic subtest: 0-rcs0 [994.479239] Dynamic subtest 0-rcs0: SUCCESS (10.033s) [994.480103] Subtest polling: SUCCESS (10.034s) [994.547010] [120/130] ( 39s left) syncobj_wait (wait-all-complex) [994.625902] Starting subtest: wait-all-complex [994.842089] Subtest wait-all-complex: SUCCESS (0.215s) [995.025177] [121/130] ( 38s left) dmabuf (all-tests) [995.076467] Starting subtest: all-tests [995.077841] Starting dynamic subtest: sanitycheck [995.207349] Dynamic subtest sanitycheck: SUCCESS (0.129s) [995.227185] Starting dynamic subtest: dma_fence [995.442276] Dynamic subtest dma_fence: SUCCESS (0.232s) [995.489141] Starting dynamic subtest: dma_fence_chain [1004.984079] Dynamic subtest dma_fence_chain: SUCCESS (9.538s) [1005.006097] Starting dynamic subtest: dma_fence_unwrap [1005.084901] Dynamic subtest dma_fence_unwrap: SUCCESS (0.098s) [1005.131346] Starting dynamic subtest: dma_resv [1005.196881] Dynamic subtest dma_resv: SUCCESS (0.108s) [1005.201487] Subtest all-tests: SUCCESS (10.122s) [1005.358014] [122/130] ( 28s left) dumb_buffer (map-invalid-size) [1005.434208] Starting subtest: map-invalid-size [1005.435119] Subtest map-invalid-size: SUCCESS (0.000s) [1005.610934] [123/130] ( 28s left) kms_chamelium_hpd (vga-hpd) [1005.872947] Subtest vga-hpd: SKIP (0.000s) [1006.042898] [124/130] ( 27s left) kms_busy (basic) [1006.233891] Starting subtest: basic [1006.234785] Starting dynamic subtest: flip [1006.914885] Dynamic subtest flip: SUCCESS (0.680s) [1006.952807] Starting dynamic subtest: modeset [1007.824982] Dynamic subtest modeset: SUCCESS (0.907s) [1007.826068] Subtest basic: SUCCESS (1.593s) [1008.147500] [125/130] ( 25s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [1008.340770] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [1008.342495] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [1008.549189] [126/130] ( 25s left) i915_drm_fdinfo (busy) [1008.617633] Starting subtest: busy [1008.618713] Starting dynamic subtest: rcs0 [1008.620502] Dynamic subtest rcs0: SKIP (0.000s) [1008.635651] Starting dynamic subtest: bcs0 [1008.638053] Dynamic subtest bcs0: SKIP (0.000s) [1008.652348] Starting dynamic subtest: vcs0 [1008.654591] Dynamic subtest vcs0: SKIP (0.000s) [1008.668857] Starting dynamic subtest: vcs1 [1008.670799] Dynamic subtest vcs1: SKIP (0.000s) [1008.685018] Starting dynamic subtest: vecs0 [1008.687109] Dynamic subtest vecs0: SKIP (0.000s) [1008.701267] Starting dynamic subtest: vecs1 [1008.703211] Dynamic subtest vecs1: SKIP (0.000s) [1008.720021] Starting dynamic subtest: ccs0 [1008.722137] Dynamic subtest ccs0: SKIP (0.013s) [1008.724196] Subtest busy: SKIP (0.023s) [1008.772734] [127/130] ( 25s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [1008.849065] Starting subtest: invalid-multi-wait-unsubmitted-submitted [1008.849968] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [1009.011145] [128/130] ( 25s left) kms_pm_lpsp (screens-disabled) [1010.200194] Starting subtest: screens-disabled [1010.201900] Subtest screens-disabled: SKIP (0.000s) [1010.367634] [129/130] ( 23s left) kms_async_flips (invalid-async-flip-atomic) [1010.555048] Starting subtest: invalid-async-flip-atomic [1010.779930] Starting dynamic subtest: pipe-A-DP-3 [1011.147810] Dynamic subtest pipe-A-DP-3: SUCCESS (0.368s) [1011.360334] Starting dynamic subtest: pipe-B-DP-3 [1011.500320] Dynamic subtest pipe-B-DP-3: SUCCESS (0.155s) [1011.708424] Starting dynamic subtest: pipe-C-DP-3 [1011.848259] Dynamic subtest pipe-C-DP-3: SUCCESS (0.155s) [1012.070690] Starting dynamic subtest: pipe-D-DP-3 [1012.220264] Dynamic subtest pipe-D-DP-3: SUCCESS (0.167s) [1012.221312] Subtest invalid-async-flip-atomic: SUCCESS (1.667s) [1012.744693] [130/130] ( 21s left) kms_cursor_crc (cursor-rapid-movement-256x256) [1013.159917] Starting subtest: cursor-rapid-movement-256x256 [1013.163795] Starting dynamic subtest: pipe-A-DP-3 [1013.600823] Dynamic subtest pipe-A-DP-3: SUCCESS (0.436s) [1013.652799] Starting dynamic subtest: pipe-D-DP-3 [1014.009887] Dynamic subtest pipe-D-DP-3: SUCCESS (0.370s) [1014.010779] Subtest cursor-rapid-movement-256x256: SUCCESS (0.850s) [1014.461559] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: gem_exec_schedule results: parsing output: 2/ for test: kms_psr results: parsing output: 3/ for test: kms_pipe_crc_basic results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_hdr results: parsing output: 6/ for test: gem_userptr_blits results: parsing output: 7/ for test: kms_selftest results: parsing output: 8/ for test: gem_exec_gttfill results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: i915_getparams_basic results: parsing output: 13/ for test: prime_vgem results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_ctx_shared results: parsing output: 16/ for test: kms_cursor_legacy results: parsing output: 17/ for test: kms_plane_cursor results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_psr2_su results: parsing output: 20/ for test: kms_big_fb results: parsing output: 21/ for test: kms_vblank results: parsing output: 22/ for test: template results: parsing output: 23/ for test: i915_pm_rc6_residency results: parsing output: 24/ for test: gem_exec_balancer results: parsing output: 25/ for test: kms_content_protection results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: perf_pmu results: parsing output: 28/ for test: vgem_basic results: parsing output: 29/ for test: kms_ccs results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: i915_query results: parsing output: 32/ for test: kms_cursor_crc results: parsing output: 33/ for test: api_intel_bb results: parsing output: 34/ for test: kms_addfb_basic results: parsing output: 35/ for test: kms_hdr results: parsing output: 36/ for test: kms_flip results: parsing output: 37/ for test: syncobj_wait results: parsing output: 38/ for test: gem_ctx_persistence results: parsing output: 39/ for test: kms_pm_rpm results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_sequence results: parsing output: 42/ for test: gen9_exec_parse results: parsing output: 43/ for test: gem_exec_whisper results: parsing output: 44/ for test: kms_plane_scaling results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: kms_cursor_crc results: parsing output: 48/ for test: gem_exec_suspend results: parsing output: 49/ for test: kms_properties results: parsing output: 50/ for test: gem_ctx_isolation results: parsing output: 51/ for test: kms_flip results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_wait results: parsing output: 55/ for test: perf results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: syncobj_timeline results: parsing output: 58/ for test: gem_exec_capture results: parsing output: 59/ for test: syncobj_timeline results: parsing output: 60/ for test: kms_flip_scaled_crc results: parsing output: 61/ for test: drm_read results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: api_intel_allocator results: parsing output: 64/ for test: gem_exec_store results: parsing output: 65/ for test: syncobj_wait results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: gem_eio results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: syncobj_basic results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_psr2_sf results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: perf results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: kms_joiner results: parsing output: 81/ for test: kms_flip_scaled_crc results: parsing output: 82/ for test: gem_exec_fence results: parsing output: 83/ for test: kms_chamelium_color results: parsing output: 84/ for test: gem_exec_flush results: parsing output: 85/ for test: gem_exec_reloc results: parsing output: 86/ for test: gem_mmap_wc results: parsing output: 87/ for test: gem_mmap_gtt results: parsing output: 88/ for test: kms_chamelium_hpd results: parsing output: 89/ for test: gem_eio results: parsing output: 90/ for test: prime_mmap results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_hdmi_inject results: parsing output: 93/ for test: perf_pmu results: parsing output: 94/ for test: kms_plane_scaling results: parsing output: 95/ for test: gem_mmap_gtt results: parsing output: 96/ for test: gem_softpin results: parsing output: 97/ for test: gem_exec_schedule results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_create results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: kms_atomic_transition results: parsing output: 103/ for test: gem_workarounds results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: gem_exec_capture results: parsing output: 106/ for test: gem_mmap_gtt results: parsing output: 107/ for test: kms_ccs results: parsing output: 108/ for test: syncobj_timeline results: parsing output: 109/ for test: kms_big_fb results: parsing output: 110/ for test: kms_pipe_b_c_ivb results: parsing output: 111/ for test: kms_cursor_legacy results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_render_copy results: parsing output: 114/ for test: gem_mmap_gtt results: parsing output: 115/ for test: gem_softpin results: parsing output: 116/ for test: kms_dp_link_training results: parsing output: 117/ for test: gem_render_copy results: parsing output: 118/ for test: perf results: parsing output: 119/ for test: syncobj_wait results: parsing output: 120/ for test: dmabuf results: parsing output: 121/ for test: dumb_buffer results: parsing output: 122/ for test: kms_chamelium_hpd results: parsing output: 123/ for test: kms_busy results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: i915_drm_fdinfo results: parsing output: 126/ for test: syncobj_timeline results: parsing output: 127/ for test: kms_pm_lpsp results: parsing output: 128/ for test: kms_async_flips results: parsing output: 129/ for test: kms_cursor_crc Done.