[40.854698] Initializing watchdogs [40.854727] /dev/watchdog0 [40.860511] [001/131] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [40.949073] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [40.951411] Starting dynamic subtest: pipe-A [41.031766] Dynamic subtest pipe-A: SUCCESS (0.083s) [41.037449] Starting dynamic subtest: pipe-B [42.269966] Dynamic subtest pipe-B: SUCCESS (1.237s) [42.278213] Starting dynamic subtest: pipe-C [43.462720] Dynamic subtest pipe-C: SUCCESS (1.193s) [43.469680] Starting dynamic subtest: pipe-D [44.677589] Dynamic subtest pipe-D: SUCCESS (1.215s) [44.680049] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.729s) [45.899115] [002/131] (955s left) kms_color (ctm-signed) [45.975726] Starting subtest: ctm-signed [45.978046] Starting dynamic subtest: pipe-A-eDP-1 [48.048280] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.036s) [48.056219] Starting dynamic subtest: pipe-B-eDP-1 [50.920087] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s) [50.926700] Starting dynamic subtest: pipe-C-eDP-1 [53.670693] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.680s) [53.676051] Starting dynamic subtest: pipe-D-eDP-1 [56.404897] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.684s) [56.407334] Subtest ctm-signed: SUCCESS (10.164s) [57.291921] [003/131] (944s left) dmabuf (all-tests) [57.322804] Starting subtest: all-tests [57.325170] Starting dynamic subtest: sanitycheck [57.427124] Dynamic subtest sanitycheck: SUCCESS (0.103s) [57.434886] Starting dynamic subtest: dma_fence [57.657689] Dynamic subtest dma_fence: SUCCESS (0.226s) [57.664738] Starting dynamic subtest: dma_fence_chain [66.524382] Dynamic subtest dma_fence_chain: SUCCESS (8.800s) [66.531944] Starting dynamic subtest: dma_fence_unwrap [66.609423] Dynamic subtest dma_fence_unwrap: SUCCESS (0.085s) [66.617782] Starting dynamic subtest: dma_resv [66.718533] Dynamic subtest dma_resv: SUCCESS (0.108s) [66.721704] Subtest all-tests: SUCCESS (9.324s) [66.758443] [004/131] (934s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [66.872113] Starting subtest: 2x-long-flip-vs-cursor-legacy [66.876739] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [66.991295] [005/131] (934s left) gem_pwrite (basic-exhaustion) [67.044072] Subtest basic-exhaustion: SKIP (0.000s) [67.081618] [006/131] (934s left) gem_lmem_swapping (parallel-random) [67.122887] Subtest parallel-random: SKIP (0.000s) [67.136314] [007/131] (934s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf) [72.246852] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf [72.252052] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [73.161455] [008/131] (928s left) kms_plane (planar-pixel-format-settings) [73.253801] Starting subtest: planar-pixel-format-settings [73.280346] Subtest planar-pixel-format-settings: SUCCESS (0.024s) [73.334402] [009/131] (928s left) kms_chamelium_color (ctm-red-to-blue) [73.431195] Subtest ctm-red-to-blue: SKIP (0.000s) [73.450619] [010/131] (928s left) kms_psr (fbc-psr2-cursor-plane-onoff) [73.547864] Starting subtest: fbc-psr2-cursor-plane-onoff [73.550180] Starting dynamic subtest: eDP-1 [73.554313] Dynamic subtest eDP-1: SKIP (0.000s) [73.558451] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s) [73.594838] [011/131] (928s left) kms_rmfb (rmfb-ioctl) [73.685789] Starting subtest: rmfb-ioctl [73.688191] Starting dynamic subtest: pipe-A-eDP-1 [73.793427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s) [73.800682] Starting dynamic subtest: pipe-B-eDP-1 [75.070334] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.274s) [75.077708] Starting dynamic subtest: pipe-C-eDP-1 [76.274971] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s) [76.282469] Starting dynamic subtest: pipe-D-eDP-1 [77.492729] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s) [77.495133] Subtest rmfb-ioctl: SUCCESS (3.802s) [78.730104] [012/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [78.831308] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [83.107887] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.275s) [83.206163] [013/131] (918s left) gem_ctx_sseu (engines) [83.248981] Subtest engines: SKIP (0.000s) [83.284770] [014/131] (918s left) gem_tiled_partial_pwrite_pread (reads) [83.339612] Subtest reads: SKIP (0.000s) [83.374086] [015/131] (918s left) syncobj_timeline (single-wait-all-available-signaled) [83.422066] Starting subtest: single-wait-all-available-signaled [83.424706] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [83.475621] [016/131] (918s left) kms_prime (basic-crc-vgem) [84.197999] Starting subtest: basic-crc-vgem [84.199684] Starting dynamic subtest: second-to-first [85.024442] Dynamic subtest second-to-first: SUCCESS (0.828s) [85.026544] Subtest basic-crc-vgem: SUCCESS (0.828s) [85.085113] [017/131] (916s left) gem_mmap_offset (open-flood) [85.132181] Starting subtest: open-flood [106.627508] Subtest open-flood: SUCCESS (21.484s) [106.719153] [018/131] (895s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [106.809433] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [106.811403] Starting dynamic subtest: pipe-A-eDP-1 [106.830970] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [106.837742] Starting dynamic subtest: pipe-B-eDP-1 [106.855916] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [106.861480] Starting dynamic subtest: pipe-C-eDP-1 [106.879375] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [106.884739] Starting dynamic subtest: pipe-D-eDP-1 [106.903303] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [106.906786] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.003s) [109.128638] [019/131] (892s left) kms_psr (psr2-sprite-mmap-gtt) [109.213922] Starting subtest: psr2-sprite-mmap-gtt [109.216292] Starting dynamic subtest: eDP-1 [110.670825] Dynamic subtest eDP-1: SKIP (1.451s) [110.676833] Subtest psr2-sprite-mmap-gtt: SKIP (1.452s) [110.772052] [020/131] (891s left) gem_close_race (multigpu-basic-threads) [110.823953] Starting subtest: multigpu-basic-threads [110.828616] Subtest multigpu-basic-threads: SKIP (0.000s) [111.023817] [021/131] (890s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [111.109899] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [111.114526] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [112.264761] [022/131] (889s left) gem_sync (basic-all) [112.324611] Starting subtest: basic-all [116.392075] Subtest basic-all: SUCCESS (4.079s) [116.554585] [023/131] (885s left) api_intel_bb (blit-noreloc-purge-cache) [116.613241] Starting subtest: blit-noreloc-purge-cache [116.619600] Subtest blit-noreloc-purge-cache: SUCCESS (0.009s) [116.720992] [024/131] (885s left) kms_cursor_crc (cursor-size-change) [116.804957] Starting subtest: cursor-size-change [116.807315] Starting dynamic subtest: pipe-A-eDP-1 [117.559180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.751s) [117.566355] Starting dynamic subtest: pipe-D-eDP-1 [119.100481] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.540s) [119.103282] Subtest cursor-size-change: SUCCESS (2.293s) [119.962749] [025/131] (882s left) gem_exec_schedule (noreorder-priority) [120.130925] Starting subtest: noreorder-priority [120.133910] Starting dynamic subtest: rcs0 [121.277142] Dynamic subtest rcs0: SUCCESS (1.146s) [121.285686] Starting dynamic subtest: vcs0 [122.426151] Dynamic subtest vcs0: SUCCESS (1.148s) [122.439065] Starting dynamic subtest: vcs1 [124.378368] Dynamic subtest vcs1: SUCCESS (1.949s) [124.388761] Starting dynamic subtest: vecs0 [126.357984] Dynamic subtest vecs0: SUCCESS (1.979s) [126.367161] Starting dynamic subtest: ccs0 [127.517500] Dynamic subtest ccs0: SUCCESS (1.160s) [127.520655] Subtest noreorder-priority: SUCCESS (7.385s) [127.677985] [026/131] (874s left) kms_cursor_crc (cursor-random-64x64) [127.825728] Starting subtest: cursor-random-64x64 [127.828216] Starting dynamic subtest: pipe-A-eDP-1 [131.128853] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.298s) [131.149881] Starting dynamic subtest: pipe-D-eDP-1 [135.202725] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.055s) [135.205020] Subtest cursor-random-64x64: SUCCESS (7.374s) [136.064791] [027/131] (866s left) gem_ctx_shared (q-in-order) [136.115842] Starting subtest: Q-in-order [136.118222] Starting dynamic subtest: rcs0 [136.205618] Dynamic subtest rcs0: SUCCESS (0.089s) [136.213235] Starting dynamic subtest: vcs0 [136.279824] Dynamic subtest vcs0: SUCCESS (0.074s) [136.286172] Starting dynamic subtest: vcs1 [136.347708] Dynamic subtest vcs1: SUCCESS (0.067s) [136.360426] Starting dynamic subtest: vecs0 [136.409147] Dynamic subtest vecs0: SUCCESS (0.061s) [136.421185] Starting dynamic subtest: ccs0 [136.471108] Dynamic subtest ccs0: SUCCESS (0.061s) [136.473590] Subtest Q-in-order: SUCCESS (0.355s) [137.465710] [028/131] (864s left) kms_chamelium_frames (dp-crc-fast) [137.851868] Subtest dp-crc-fast: SKIP (0.000s) [138.740874] [029/131] (863s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [138.780658] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [138.884168] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [138.937115] [030/131] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [139.036095] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [139.040484] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [139.101428] [031/131] (863s left) gem_exec_schedule (reorder-wide) [139.284938] Subtest reorder-wide: SKIP (0.000s) [139.438849] [032/131] (862s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [139.523586] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [139.525987] Starting dynamic subtest: pipe-A-eDP-1 [139.583356] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [139.588833] Starting dynamic subtest: pipe-B-eDP-1 [139.646802] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [139.654272] Starting dynamic subtest: pipe-C-eDP-1 [139.711956] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [139.720047] Starting dynamic subtest: pipe-D-eDP-1 [139.775492] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [139.779470] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [141.833954] [033/131] (860s left) gem_flink_race (flink_close) [141.859341] Starting subtest: flink_close [146.951373] Subtest flink_close: SUCCESS (5.091s) [146.999603] [034/131] (855s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [147.065106] Starting subtest: multi-wait-all-for-submit-unsubmitted [147.171424] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s) [147.223205] [035/131] (854s left) gem_exec_balancer (semaphore) [147.274547] Starting subtest: semaphore [149.789141] Subtest semaphore: SUCCESS (2.514s) [150.015778] [036/131] (852s left) kms_big_fb (4-tiled-addfb) [150.108873] Starting subtest: 4-tiled-addfb [150.110836] Subtest 4-tiled-addfb: SUCCESS (0.000s) [150.192379] [037/131] (852s left) kms_big_fb (x-tiled-16bpp-rotate-0) [150.289803] Starting subtest: x-tiled-16bpp-rotate-0 [151.322094] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.033s) [151.418415] [038/131] (850s left) gem_exec_reloc (basic-gtt-read-noreloc) [151.470036] Subtest basic-gtt-read-noreloc: SKIP (0.000s) [151.516914] [039/131] (850s left) kms_content_protection (dp-mst-type-1) [151.647590] Starting subtest: dp-mst-type-1 [151.651888] Subtest dp-mst-type-1: SKIP (0.000s) [151.758589] [040/131] (850s left) gem_tiled_wb [151.844899] [041/131] (850s left) gem_mmap_wc (read-write) [151.895648] Subtest read-write: SKIP (0.000s) [151.935583] [042/131] (850s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [152.028321] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [152.030351] Starting dynamic subtest: pipe-A-eDP-1 [152.047636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [152.053493] Starting dynamic subtest: pipe-B-eDP-1 [152.069443] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [152.074748] Starting dynamic subtest: pipe-C-eDP-1 [152.090872] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [152.096276] Starting dynamic subtest: pipe-D-eDP-1 [152.112755] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [152.114626] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [154.376225] [043/131] (847s left) api_intel_bb (reset-flags) [154.425442] Starting subtest: reset-flags [154.434787] Subtest reset-flags: SUCCESS (0.011s) [154.512349] [044/131] (847s left) kms_addfb_basic (legacy-format) [154.559757] Starting subtest: legacy-format [154.593481] Subtest legacy-format: SUCCESS (0.023s) [154.694411] [045/131] (847s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [154.792672] Starting subtest: fbcpsr-slowdraw [177.591254] Subtest fbcpsr-slowdraw: SUCCESS (22.802s) [177.700448] [046/131] (824s left) fbdev (eof) [177.734540] Starting subtest: eof [177.736693] Subtest eof: SUCCESS (0.000s) [177.764619] [047/131] (824s left) gem_mmap_gtt (basic-read) [177.813755] Subtest basic-read: SKIP (0.000s) [177.852047] [048/131] (824s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [177.901206] Starting subtest: single-wait-all-for-submit-unsubmitted [178.012225] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.109s) [178.062168] [049/131] (824s left) kms_atomic (atomic-plane-damage) [178.146032] Starting subtest: atomic-plane-damage [178.198516] Starting dynamic subtest: pipe-A-eDP-1 [178.724641] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.526s) [178.727099] Subtest atomic-plane-damage: SUCCESS (0.578s) [179.594303] [050/131] (822s left) kms_cursor_crc (cursor-onscreen-max-size) [179.834631] Starting subtest: cursor-onscreen-max-size [179.841323] Subtest cursor-onscreen-max-size: SKIP (0.000s) [179.949238] [051/131] (822s left) gem_partial_pwrite_pread (write) [180.003257] Subtest write: SKIP (0.000s) [180.047959] [052/131] (822s left) kms_pm_dc (dc5-dpms-negative) [181.140587] Starting subtest: dc5-dpms-negative [181.146193] Subtest dc5-dpms-negative: SKIP (0.000s) [181.192272] [053/131] (821s left) kms_frontbuffer_tracking (psr-slowdraw) [181.285714] Starting subtest: psr-slowdraw [204.061398] Subtest psr-slowdraw: SUCCESS (22.777s) [204.159069] [054/131] (798s left) gem_exec_parallel (basic) [204.202356] Starting subtest: basic [204.204586] Starting dynamic subtest: rcs0 [205.577831] Dynamic subtest rcs0: SUCCESS (1.375s) [205.586346] Starting dynamic subtest: bcs0 [206.903499] Dynamic subtest bcs0: SUCCESS (1.325s) [206.912053] Starting dynamic subtest: vcs0 [208.388446] Dynamic subtest vcs0: SUCCESS (1.483s) [208.397137] Starting dynamic subtest: vcs1 [210.345553] Dynamic subtest vcs1: SUCCESS (1.956s) [210.353087] Starting dynamic subtest: vecs0 [212.392625] Dynamic subtest vecs0: SUCCESS (2.045s) [212.403266] Starting dynamic subtest: ccs0 [213.819409] Dynamic subtest ccs0: SUCCESS (1.427s) [213.822594] Subtest basic: SUCCESS (9.616s) [213.983955] [055/131] (788s left) gem_pxp (create-valid-protected-context) [216.554966] Subtest create-valid-protected-context: SKIP (0.000s) [216.603363] [056/131] (785s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [216.706074] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [221.518575] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (4.815s) [221.605652] [057/131] (780s left) perf (invalid-oa-format-id) [221.705825] Starting subtest: invalid-oa-format-id [221.718072] Subtest invalid-oa-format-id: SUCCESS (0.011s) [221.737971] [058/131] (780s left) prime_busy (after-wait) [221.792097] Starting subtest: after-wait [221.797025] Starting dynamic subtest: rcs0 [221.839301] Dynamic subtest rcs0: SUCCESS (0.043s) [221.848147] Starting dynamic subtest: bcs0 [221.890893] Dynamic subtest bcs0: SUCCESS (0.052s) [221.896712] Starting dynamic subtest: vcs0 [221.931055] Dynamic subtest vcs0: SUCCESS (0.040s) [221.938059] Starting dynamic subtest: vcs1 [221.972291] Dynamic subtest vcs1: SUCCESS (0.040s) [221.980682] Starting dynamic subtest: vecs0 [222.014403] Dynamic subtest vecs0: SUCCESS (0.041s) [222.022696] Starting dynamic subtest: ccs0 [222.054648] Dynamic subtest ccs0: SUCCESS (0.040s) [222.163214] Subtest after-wait: SUCCESS (0.369s) [222.214743] [059/131] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [222.324544] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [222.328755] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [222.411629] [060/131] (780s left) gem_exec_balancer (nohangcheck) [222.624958] Starting subtest: nohangcheck [223.091359] Subtest nohangcheck: SUCCESS (0.468s) [223.183659] [061/131] (779s left) i915_hangman (error-state-basic) [223.226952] Starting subtest: error-state-basic [223.374420] Subtest error-state-basic: SUCCESS (0.147s) [223.424169] [062/131] (779s left) gem_tiled_blits (normal) [223.472539] Subtest normal: SKIP (0.000s) [223.510886] [063/131] (779s left) gem_spin_batch (legacy-resubmit) [223.563402] Starting subtest: legacy-resubmit [223.565985] Starting dynamic subtest: default [223.571248] Dynamic subtest default: SUCCESS (0.006s) [223.578053] Starting dynamic subtest: render [223.580433] Dynamic subtest render: SUCCESS (0.001s) [223.586279] Starting dynamic subtest: bsd [223.588520] Dynamic subtest bsd: SUCCESS (0.002s) [223.594257] Starting dynamic subtest: bsd1 [223.596545] Dynamic subtest bsd1: SUCCESS (0.001s) [223.602309] Starting dynamic subtest: bsd2 [223.604640] Dynamic subtest bsd2: SUCCESS (0.002s) [223.610438] Starting dynamic subtest: blt [223.612726] Dynamic subtest blt: SUCCESS (0.002s) [223.618559] Starting dynamic subtest: vebox [223.620850] Dynamic subtest vebox: SUCCESS (0.002s) [223.623166] Subtest legacy-resubmit: SUCCESS (0.017s) [223.754348] [064/131] (778s left) kms_psr (pr-cursor-render) [223.838918] Starting subtest: pr-cursor-render [223.843382] Subtest pr-cursor-render: SKIP (0.000s) [223.886462] [065/131] (778s left) syncobj_basic (bad-fd-to-handle) [223.933801] Starting subtest: bad-fd-to-handle [223.935964] Subtest bad-fd-to-handle: SUCCESS (0.000s) [223.987776] [066/131] (778s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [224.084642] Starting subtest: fbc-2p-primscrn-cur-indfb-move [224.089051] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [224.152963] [067/131] (778s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [224.237538] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [224.239519] Starting dynamic subtest: pipe-A-default-mode [224.526344] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [224.530611] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.283s) [225.420479] [068/131] (777s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [225.512902] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [225.515242] Starting dynamic subtest: pipe-A-eDP-1 [225.537817] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [225.543387] Starting dynamic subtest: pipe-B-eDP-1 [225.565194] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [225.571084] Starting dynamic subtest: pipe-C-eDP-1 [225.592992] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [225.598680] Starting dynamic subtest: pipe-D-eDP-1 [225.619547] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [225.623700] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [227.849298] [069/131] (774s left) i915_pm_rpm (gem-mmap-type) [229.456662] Starting subtest: gem-mmap-type [229.459399] Starting dynamic subtest: wb-smem0 [233.217536] Dynamic subtest wb-smem0: SUCCESS (3.757s) [233.223740] Starting dynamic subtest: wc-smem0 [236.300461] Dynamic subtest wc-smem0: SUCCESS (3.085s) [236.308144] Starting dynamic subtest: uc-smem0 [239.415264] Dynamic subtest uc-smem0: SUCCESS (3.113s) [239.417658] Subtest gem-mmap-type: SUCCESS (9.957s) [239.476094] [070/131] (763s left) kms_addfb_basic (invalid-get-prop) [239.526904] Starting subtest: invalid-get-prop [239.529373] Subtest invalid-get-prop: SUCCESS (0.000s) [239.632408] [071/131] (763s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [244.736768] Starting subtest: psr2-overlay-plane-update-continuous-sf [244.739159] Starting dynamic subtest: pipe-A-eDP-1 [246.543329] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.805s) [246.550687] Starting dynamic subtest: pipe-B-eDP-1 [248.346187] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.801s) [248.348692] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.609s) [249.227105] [072/131] (753s left) gem_ctx_param (invalid-param-get) [249.270033] Starting subtest: invalid-param-get [249.272889] Subtest invalid-param-get: SUCCESS (0.001s) [249.328275] [073/131] (753s left) kms_vblank (query-forked) [249.413854] Starting subtest: query-forked [249.416075] Starting dynamic subtest: pipe-A-eDP-1 [251.211134] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.795s) [251.221901] Starting dynamic subtest: pipe-D-eDP-1 [253.768280] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s) [253.771154] Subtest query-forked: SUCCESS (4.352s) [254.664148] [074/131] (748s left) gem_exec_whisper (basic-fds-all) [254.716021] Starting subtest: basic-fds-all [264.617920] Subtest basic-fds-all: SUCCESS (9.899s) [264.779032] [075/131] (737s left) kms_invalid_mode (bad-hsync-start) [264.888858] Starting subtest: bad-hsync-start [264.891133] Starting dynamic subtest: pipe-A-eDP-1 [265.171478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s) [265.180047] Starting dynamic subtest: pipe-B-eDP-1 [265.182622] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [265.189225] Starting dynamic subtest: pipe-C-eDP-1 [265.192207] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [265.199161] Starting dynamic subtest: pipe-D-eDP-1 [265.202152] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [265.205256] Subtest bad-hsync-start: SUCCESS (0.284s) [266.058093] [076/131] (736s left) syncobj_wait (wait-all-complex) [266.103822] Starting subtest: wait-all-complex [266.320284] Subtest wait-all-complex: SUCCESS (0.217s) [266.375307] [077/131] (736s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [266.466465] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [266.470601] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [266.549178] [078/131] (736s left) syncobj_basic (bad-pad-handle-to-fd) [266.598048] Starting subtest: bad-pad-handle-to-fd [266.600159] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [266.664143] [079/131] (736s left) kms_vblank (wait-idle-hang) [266.743842] Starting subtest: wait-idle-hang [266.746216] Starting dynamic subtest: pipe-A-eDP-1 [281.182118] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.435s) [281.193536] Starting dynamic subtest: pipe-D-eDP-1 [296.146744] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.961s) [296.149273] Subtest wait-idle-hang: SUCCESS (29.401s) [297.032036] [080/131] (705s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [297.138502] Starting subtest: cursorA-vs-flipB-varying-size [297.142978] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [297.225024] [081/131] (705s left) perf_pmu (enable-race) [297.259485] Starting subtest: enable-race [297.261697] Starting dynamic subtest: rcs0 [309.992618] Dynamic subtest rcs0: SUCCESS (12.733s) [310.002526] Starting dynamic subtest: bcs0 [322.720310] Dynamic subtest bcs0: SUCCESS (12.727s) [322.729930] Starting dynamic subtest: vcs0 [338.343952] Dynamic subtest vcs0: SUCCESS (15.621s) [338.352035] Starting dynamic subtest: vcs1 [354.343984] Dynamic subtest vcs1: SUCCESS (15.998s) [354.352898] Starting dynamic subtest: vecs0 [370.344287] Dynamic subtest vecs0: SUCCESS (15.998s) [370.353440] Starting dynamic subtest: ccs0 [383.184986] Dynamic subtest ccs0: SUCCESS (12.840s) [383.187618] Subtest enable-race: SUCCESS (85.923s) [383.248841] [082/131] (619s left) sysfs_timeslice_duration (invalid) [383.300023] Starting subtest: invalid [383.302268] Starting dynamic subtest: vecs0 [383.304445] Dynamic subtest vecs0: SUCCESS (0.000s) [383.310285] Starting dynamic subtest: ccs0 [383.312147] Dynamic subtest ccs0: SUCCESS (0.000s) [383.318204] Starting dynamic subtest: vcs0 [383.320321] Dynamic subtest vcs0: SUCCESS (0.000s) [383.326038] Starting dynamic subtest: bcs0 [383.327845] Dynamic subtest bcs0: SUCCESS (0.000s) [383.337094] Starting dynamic subtest: rcs0 [383.339398] Dynamic subtest rcs0: SUCCESS (0.000s) [383.345739] Starting dynamic subtest: vcs1 [383.347854] Dynamic subtest vcs1: SUCCESS (0.000s) [383.349814] Subtest invalid: SUCCESS (0.003s) [383.364588] [083/131] (619s left) kms_lease (simple-lease) [383.456966] Starting subtest: simple-lease [383.459273] Starting dynamic subtest: pipe-A-eDP-1 [383.937788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.477s) [383.944920] Starting dynamic subtest: pipe-B-eDP-1 [385.462144] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.525s) [385.475206] Starting dynamic subtest: pipe-C-eDP-1 [386.980935] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.515s) [386.988600] Starting dynamic subtest: pipe-D-eDP-1 [388.451070] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.469s) [388.453220] Subtest simple-lease: SUCCESS (4.992s) [389.322853] [084/131] (613s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [389.407826] Starting subtest: yf-tiled-8bpp-rotate-90 [389.412544] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [389.474440] [085/131] (613s left) kms_psr (fbc-psr-no-drrs) [389.559893] Starting subtest: fbc-psr-no-drrs [389.562139] Starting dynamic subtest: eDP-1 [389.566630] Dynamic subtest eDP-1: SKIP (0.000s) [389.570948] Subtest fbc-psr-no-drrs: SKIP (0.001s) [389.614061] [086/131] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [389.705975] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [389.710139] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [389.763204] [087/131] (613s left) kms_scaling_modes (scaling-mode-full-aspect) [389.848873] Starting subtest: scaling-mode-full-aspect [389.851225] Starting dynamic subtest: pipe-A-eDP-1 [389.941191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.091s) [389.948331] Starting dynamic subtest: pipe-B-eDP-1 [391.195849] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s) [391.202271] Starting dynamic subtest: pipe-C-eDP-1 [392.391747] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s) [392.401196] Starting dynamic subtest: pipe-D-eDP-1 [393.607703] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s) [393.610190] Subtest scaling-mode-full-aspect: SUCCESS (3.759s) [394.830275] [088/131] (608s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [394.880722] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [394.922867] [089/131] (608s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [395.048827] Starting subtest: basic-flip-after-cursor-varying-size [395.972055] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.923s) [396.874338] [090/131] (606s left) gem_ctx_exec (basic-norecovery) [396.931739] Starting subtest: basic-norecovery [397.238536] Subtest basic-norecovery: SUCCESS (0.306s) [397.338710] [091/131] (605s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [397.437141] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [400.087291] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.654s) [400.188789] [092/131] (602s left) kms_dsc (dsc-fractional-bpp) [400.291049] Starting subtest: dsc-fractional-bpp [400.294994] Subtest dsc-fractional-bpp: SKIP (0.000s) [400.344266] [093/131] (602s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [400.397834] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [400.401670] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [400.556105] [094/131] (602s left) gen7_exec_parse (basic-allocation) [400.605358] Subtest basic-allocation: SKIP (0.000s) [400.647336] [095/131] (602s left) kms_psr (psr-sprite-mmap-gtt) [400.739831] Starting subtest: psr-sprite-mmap-gtt [400.742082] Starting dynamic subtest: eDP-1 [402.216335] Dynamic subtest eDP-1: SKIP (1.471s) [402.222355] Subtest psr-sprite-mmap-gtt: SKIP (1.472s) [402.368291] [096/131] (600s left) gem_ctx_param (invalid-ctx-get) [402.409110] Starting subtest: invalid-ctx-get [402.411350] Subtest invalid-ctx-get: SUCCESS (0.000s) [402.457980] [097/131] (600s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt) [402.554341] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt [402.558649] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [402.626183] [098/131] (600s left) syncobj_timeline (etime-multi-wait-submitted) [402.666032] Starting subtest: etime-multi-wait-submitted [402.772283] Subtest etime-multi-wait-submitted: SUCCESS (0.106s) [402.826712] [099/131] (600s left) gem_exec_reloc (basic-active) [402.874374] Subtest basic-active: SKIP (0.000s) [402.919297] [100/131] (600s left) kms_big_fb (y-tiled-16bpp-rotate-180) [403.013214] Starting subtest: y-tiled-16bpp-rotate-180 [403.017272] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [403.075068] [101/131] (600s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [403.170072] Starting subtest: psr-1p-primscrn-spr-indfb-move [408.433792] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (5.267s) [408.560652] [102/131] (594s left) kms_getfb (getfb-repeated-different-handles) [408.611774] Starting subtest: getfb-repeated-different-handles [408.614326] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [408.698642] [103/131] (594s left) kms_flip (busy-flip) [408.787990] Starting subtest: busy-flip [408.790325] Starting dynamic subtest: A-eDP1 [410.564864] Dynamic subtest A-eDP1: SUCCESS (1.776s) [410.574328] Starting dynamic subtest: B-eDP1 [412.297262] Dynamic subtest B-eDP1: SUCCESS (1.732s) [412.305774] Starting dynamic subtest: C-eDP1 [414.074146] Dynamic subtest C-eDP1: SUCCESS (1.775s) [414.082787] Starting dynamic subtest: D-eDP1 [415.802081] Dynamic subtest D-eDP1: SUCCESS (1.727s) [415.805162] Subtest busy-flip: SUCCESS (7.017s) [417.035933] [104/131] (586s left) kms_cursor_legacy (cursor-vs-flip-legacy) [417.149196] Starting subtest: cursor-vs-flip-legacy [445.726619] Subtest cursor-vs-flip-legacy: SUCCESS (28.573s) [446.607624] [105/131] (556s left) syncobj_timeline (multi-wait-all-available-submitted) [446.662420] Starting subtest: multi-wait-all-available-submitted [446.665120] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s) [446.724373] [106/131] (556s left) gem_exec_whisper (basic-queues-priority) [446.780822] Starting subtest: basic-queues-priority [470.433638] Subtest basic-queues-priority: SUCCESS (23.648s) [470.592359] [107/131] (532s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [470.675919] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [470.678177] Starting dynamic subtest: pipe-A-default-mode [470.964816] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [470.969398] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.286s) [471.816913] [108/131] (531s left) kms_cursor_edge_walk (64x64-right-edge) [471.906864] Starting subtest: 64x64-right-edge [471.909193] Starting dynamic subtest: pipe-A-eDP-1 [475.448889] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.539s) [475.457160] Starting dynamic subtest: pipe-D-eDP-1 [478.698731] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.250s) [478.701378] Subtest 64x64-right-edge: SUCCESS (6.790s) [479.564131] [109/131] (523s left) gem_userptr_blits (unsync-unmap) [479.610852] Subtest unsync-unmap: SKIP (0.000s) [479.709698] [110/131] (523s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [479.797619] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [479.812324] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.013s) [479.867150] [111/131] (523s left) kms_hdr (bpc-switch-dpms) [479.950787] Starting subtest: bpc-switch-dpms [481.064839] Starting dynamic subtest: pipe-A-eDP-1 [485.800177] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.734s) [485.802565] Subtest bpc-switch-dpms: SUCCESS (5.848s) [485.902177] [112/131] (517s left) syncobj_wait (wait-all-snapshot) [485.948658] Starting subtest: wait-all-snapshot [486.028050] Subtest wait-all-snapshot: SUCCESS (0.082s) [486.079146] [113/131] (517s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [486.176150] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [491.121572] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.947s) [491.230221] [114/131] (512s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [491.318842] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [491.321155] Starting dynamic subtest: pipe-A-default-mode [492.512710] Dynamic subtest pipe-A-default-mode: SKIP (1.188s) [492.517767] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.190s) [492.633111] [115/131] (510s left) syncobj_timeline (single-wait-signaled) [492.683896] Starting subtest: single-wait-signaled [492.686386] Subtest single-wait-signaled: SUCCESS (0.000s) [492.754889] [116/131] (510s left) kms_pm_rpm (pc8-residency) [494.565085] Starting subtest: pc8-residency [494.570228] Subtest pc8-residency: SKIP (0.000s) [495.029948] [117/131] (508s left) gem_mmap_wc (write-read) [495.086440] Subtest write-read: SKIP (0.000s) [495.123229] [118/131] (508s left) gem_softpin (evict-snoop) [495.173099] Starting subtest: evict-snoop [495.177730] Subtest evict-snoop: SKIP (0.000s) [495.263790] [119/131] (508s left) syncobj_eventfd (invalid-illegal-eventfd) [495.308821] Starting subtest: invalid-illegal-eventfd [495.311306] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [495.382139] [120/131] (508s left) prime_self_import (basic-with_two_bos) [495.411067] Starting subtest: basic-with_two_bos [495.433797] Subtest basic-with_two_bos: SUCCESS (0.021s) [495.494973] [121/131] (507s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [495.593943] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [496.127970] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.536s) [496.254122] [122/131] (507s left) i915_pm_rps (fence-order) [496.307471] Starting subtest: fence-order [499.307607] Subtest fence-order: SUCCESS (2.999s) [499.369093] [123/131] (504s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [499.474738] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [528.978270] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (29.501s) [529.867377] [124/131] (473s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [529.966906] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [529.971916] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [530.028836] [125/131] (473s left) gem_exec_reloc (basic-wc-gtt-active) [530.087230] Subtest basic-wc-gtt-active: SKIP (0.000s) [530.128635] [126/131] (473s left) kms_big_fb (y-tiled-64bpp-rotate-180) [530.215829] Starting subtest: y-tiled-64bpp-rotate-180 [530.219976] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [530.277402] [127/131] (473s left) kms_plane_alpha_blend (constant-alpha-min) [530.378863] Starting subtest: constant-alpha-min [530.652136] Starting dynamic subtest: pipe-A-eDP-1 [531.363693] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [531.371588] Starting dynamic subtest: pipe-D-eDP-1 [532.881239] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.517s) [532.883802] Subtest constant-alpha-min: SUCCESS (2.500s) [533.775163] [128/131] (469s left) gem_spin_batch (spin-each) [533.828214] Starting subtest: spin-each [537.090093] Subtest spin-each: SUCCESS (3.253s) [538.378500] [129/131] (465s left) gem_exec_fence (submit67) [538.531743] Starting subtest: submit67 [538.536100] Subtest submit67: SKIP (0.000s) [540.463402] [130/131] (463s left) gem_ctx_param (invalid-get-engines) [540.500682] Starting subtest: invalid-get-engines [540.503130] Subtest invalid-get-engines: SUCCESS (0.001s) [540.573600] [131/131] (463s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [540.688059] Starting subtest: cursorB-vs-flipB-atomic-transitions [540.692541] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [540.762020] Closing watchdogs Done.