[98.067018] Initializing watchdogs [98.067067] /dev/watchdog0 [98.082213] [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] [98.086479] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [98.088719] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [98.092353] [001/133] (960s left) kms_chamelium_hpd (vga-hpd-fast) [98.504365] Subtest vga-hpd-fast: SKIP (0.000s) [99.278914] [002/133] (959s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [99.375783] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [99.378185] Starting dynamic subtest: A-eDP1 [103.012350] Dynamic subtest A-eDP1: SUCCESS (3.632s) [103.020565] Starting dynamic subtest: B-eDP1 [106.227217] Dynamic subtest B-eDP1: SUCCESS (3.217s) [106.235286] Starting dynamic subtest: C-eDP1 [109.345590] Dynamic subtest C-eDP1: SUCCESS (3.117s) [109.354223] Starting dynamic subtest: D-eDP1 [112.463615] Dynamic subtest D-eDP1: SUCCESS (3.116s) [112.465698] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.088s) [113.263424] [003/133] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [113.358208] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [113.362475] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [113.453161] [004/133] (945s left) gem_exec_schedule (pi-ringfull) [113.630762] Starting subtest: pi-ringfull [113.633061] Starting dynamic subtest: rcs0 [113.678526] Dynamic subtest rcs0: SUCCESS (0.051s) [113.693980] Starting dynamic subtest: bcs0 [113.706374] Dynamic subtest bcs0: SUCCESS (0.028s) [113.718508] Starting dynamic subtest: vcs0 [113.732258] Dynamic subtest vcs0: SUCCESS (0.025s) [113.742397] Starting dynamic subtest: vcs1 [113.758423] Dynamic subtest vcs1: SUCCESS (0.026s) [113.770087] Starting dynamic subtest: vecs0 [113.784822] Dynamic subtest vecs0: SUCCESS (0.026s) [113.794512] Starting dynamic subtest: ccs0 [113.811096] Dynamic subtest ccs0: SUCCESS (0.026s) [113.813226] Subtest pi-ringfull: SUCCESS (0.184s) [114.024351] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true [114.027439] [005/133] (944s left) kms_big_fb (x-tiled-32bpp-rotate-270) [114.126855] Starting subtest: x-tiled-32bpp-rotate-270 [114.145498] Subtest x-tiled-32bpp-rotate-270: SKIP (0.018s) [114.256757] [006/133] (944s left) gem_exec_reloc (basic-cpu-noreloc) [114.307289] Subtest basic-cpu-noreloc: SKIP (0.000s) [114.384902] [007/133] (944s left) gem_exec_fence (long-history) [114.797596] Starting subtest: long-history [121.699823] Subtest long-history: SUCCESS (6.904s) [122.383789] [008/133] (936s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [122.487051] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [122.491381] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [122.566226] [009/133] (936s left) gem_exec_balancer (hog) [122.616488] Starting subtest: hog [122.621262] Subtest hog: SKIP (0.000s) [122.912329] [010/133] (936s left) syncobj_timeline (wait-all-snapshot) [122.965217] Starting subtest: wait-all-snapshot [123.045906] Subtest wait-all-snapshot: SUCCESS (0.082s) [123.121925] [011/133] (935s left) gem_ringfill (legacy-basic) [128.921786] Starting subtest: legacy-basic [128.924029] Starting dynamic subtest: default [128.979991] Dynamic subtest default: SUCCESS (0.059s) [128.990675] Starting dynamic subtest: render [129.020039] Dynamic subtest render: SUCCESS (0.040s) [129.029219] Starting dynamic subtest: bsd [129.065620] Dynamic subtest bsd: SUCCESS (0.044s) [129.076086] Starting dynamic subtest: bsd1 [129.106605] Dynamic subtest bsd1: SUCCESS (0.040s) [129.115428] Starting dynamic subtest: bsd2 [129.150805] Dynamic subtest bsd2: SUCCESS (0.043s) [129.162708] Starting dynamic subtest: blt [129.195794] Dynamic subtest blt: SUCCESS (0.044s) [129.205106] Starting dynamic subtest: vebox [129.240099] Dynamic subtest vebox: SUCCESS (0.043s) [129.242556] Subtest legacy-basic: SUCCESS (0.322s) [129.323152] [012/133] (929s left) sw_sync (sync_multi_consumer_producer) [129.358169] Starting subtest: sync_multi_consumer_producer [129.667396] Subtest sync_multi_consumer_producer: SUCCESS (0.309s) [129.730350] [013/133] (929s left) kms_psr (fbc-pr-sprite-blt) [129.813746] Starting subtest: fbc-pr-sprite-blt [129.817874] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [129.894912] [014/133] (929s left) prime_self_import (basic-llseek-bad) [129.935373] Starting subtest: basic-llseek-bad [129.955706] Subtest basic-llseek-bad: SUCCESS (0.018s) [130.046188] [015/133] (929s left) syncobj_basic (test-valid-cycle) [130.091560] Starting subtest: test-valid-cycle [130.093715] Subtest test-valid-cycle: SUCCESS (0.000s) [130.188655] [016/133] (928s left) gem_ppgtt (blt-vs-render-ctx0) [130.240316] Starting subtest: blt-vs-render-ctx0 [163.147175] Subtest blt-vs-render-ctx0: SUCCESS (32.905s) [163.274626] [017/133] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [163.404640] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [163.408782] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [163.507709] [018/133] (895s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [163.595135] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [170.474241] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.882s) [170.631216] [019/133] (888s left) gem_exec_store (dword) [170.704085] Starting subtest: dword [170.706336] Starting dynamic subtest: rcs0 [170.770681] Dynamic subtest rcs0: SUCCESS (0.068s) [170.780774] Starting dynamic subtest: bcs0 [170.812633] Dynamic subtest bcs0: SUCCESS (0.041s) [170.820778] Starting dynamic subtest: vcs0 [170.855222] Dynamic subtest vcs0: SUCCESS (0.042s) [170.864187] Starting dynamic subtest: vcs1 [170.896079] Dynamic subtest vcs1: SUCCESS (0.040s) [170.905428] Starting dynamic subtest: vecs0 [170.938205] Dynamic subtest vecs0: SUCCESS (0.041s) [170.946226] Starting dynamic subtest: ccs0 [170.979720] Dynamic subtest ccs0: SUCCESS (0.040s) [170.982232] Subtest dword: SUCCESS (0.277s) [171.161152] [020/133] (888s left) i915_suspend (fence-restore-tiled2untiled) [171.219912] Starting subtest: fence-restore-tiled2untiled [171.224624] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [171.319094] [021/133] (888s left) kms_color (ctm-red-to-blue) [171.414440] Starting subtest: ctm-red-to-blue [171.416622] Starting dynamic subtest: pipe-A-eDP-1 [172.130284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s) [172.138486] Starting dynamic subtest: pipe-B-eDP-1 [173.578491] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.449s) [173.585992] Starting dynamic subtest: pipe-C-eDP-1 [174.955080] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s) [174.964297] Starting dynamic subtest: pipe-D-eDP-1 [176.286852] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [176.289179] Subtest ctm-red-to-blue: SUCCESS (4.872s) [177.084149] [022/133] (882s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [177.199369] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [177.209817] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s) [177.284780] [023/133] (882s left) core_hotunplug (unbind-rebind) [177.385366] Starting subtest: unbind-rebind [183.309726] Subtest unbind-rebind: SUCCESS (5.925s) [183.347865] [024/133] (876s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping) [184.873081] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping [184.877125] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s) [184.962441] [025/133] (874s left) gem_mmap_wc (fault-concurrent) [185.038723] Subtest fault-concurrent: SKIP (0.000s) [185.110654] [026/133] (874s left) kms_plane_scaling (planes-downscale-factor-0-75) [185.210816] Starting subtest: planes-downscale-factor-0-75 [185.213075] Starting dynamic subtest: pipe-A [185.235106] Dynamic subtest pipe-A: SKIP (0.020s) [185.244315] Starting dynamic subtest: pipe-B [185.272383] Dynamic subtest pipe-B: SKIP (0.038s) [185.280673] Starting dynamic subtest: pipe-C [185.306804] Dynamic subtest pipe-C: SKIP (0.035s) [185.314936] Starting dynamic subtest: pipe-D [185.341982] Dynamic subtest pipe-D: SKIP (0.036s) [185.345708] Subtest planes-downscale-factor-0-75: SKIP (0.129s) [185.427582] [027/133] (874s left) gem_ctx_param (invalid-ctx-set) [185.482620] Starting subtest: invalid-ctx-set [185.484985] Subtest invalid-ctx-set: SUCCESS (0.001s) [185.589230] [028/133] (874s left) kms_draw_crc (draw-method-pwrite) [185.676837] Starting subtest: draw-method-pwrite [185.678772] Starting dynamic subtest: xrgb8888-untiled [186.295893] Dynamic subtest xrgb8888-untiled: SUCCESS (0.620s) [186.304322] Starting dynamic subtest: rgb565-untiled [186.796279] Dynamic subtest rgb565-untiled: SUCCESS (0.500s) [186.806328] Starting dynamic subtest: xrgb2101010-untiled [187.409649] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.611s) [187.418817] Starting dynamic subtest: xbgr16161616f-untiled [188.218338] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.811s) [188.227608] Starting dynamic subtest: xrgb8888-xtiled [190.263078] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.044s) [190.275528] Starting dynamic subtest: rgb565-xtiled [191.574268] Dynamic subtest rgb565-xtiled: SUCCESS (1.310s) [191.583671] Starting dynamic subtest: xrgb2101010-xtiled [193.651935] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.077s) [193.660128] Starting dynamic subtest: xbgr16161616f-xtiled [197.240912] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.588s) [197.248913] Starting dynamic subtest: xrgb8888-4tiled [198.485351] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.243s) [198.493443] Starting dynamic subtest: rgb565-4tiled [199.152781] Dynamic subtest rgb565-4tiled: SUCCESS (0.666s) [199.163393] Starting dynamic subtest: xrgb2101010-4tiled [200.407135] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.255s) [200.416586] Starting dynamic subtest: xbgr16161616f-4tiled [203.652301] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.244s) [203.654530] Subtest draw-method-pwrite: SUCCESS (17.977s) [203.773691] [029/133] (855s left) gem_exec_params (mmapped) [203.843343] Starting subtest: mmapped [203.848220] Subtest mmapped: SUCCESS (0.003s) [203.956837] [030/133] (855s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [204.081362] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [213.083215] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.000s) [213.924260] [031/133] (845s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [214.027267] Starting subtest: addfb25-y-tiled-small-legacy [214.031732] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [214.112471] [032/133] (845s left) kms_setmode (invalid-clone-single-crtc) [214.160614] Starting subtest: invalid-clone-single-crtc [214.167088] Subtest invalid-clone-single-crtc: SKIP (0.000s) [214.241209] [033/133] (845s left) kms_dp_link_training (uhbr-mst) [214.334759] Starting subtest: uhbr-mst [214.343218] Subtest uhbr-mst: SKIP (0.000s) [214.403218] [034/133] (845s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [214.512605] Starting subtest: fbc-modesetfrombusy [218.518536] Subtest fbc-modesetfrombusy: SUCCESS (4.012s) [219.683590] [035/133] (840s left) gem_lmem_swapping (heavy-random) [219.737464] Subtest heavy-random: SKIP (0.000s) [219.778613] [036/133] (840s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [219.876191] Starting subtest: yf-tiled-8bpp-rotate-270 [219.880246] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [219.970919] [037/133] (840s left) gem_exec_schedule (semaphore-power) [220.171404] Subtest semaphore-power: SKIP (0.000s) [220.345915] [038/133] (839s left) perf_pmu (render-node-busy-idle) [220.419026] Starting subtest: render-node-busy-idle [220.421185] Starting dynamic subtest: rcs0 [221.118247] Dynamic subtest rcs0: SUCCESS (0.701s) [221.129721] Starting dynamic subtest: bcs0 [221.777997] Dynamic subtest bcs0: SUCCESS (0.658s) [221.789611] Starting dynamic subtest: vcs0 [222.933657] Dynamic subtest vcs0: SUCCESS (1.152s) [222.944883] Starting dynamic subtest: vcs1 [224.917407] Dynamic subtest vcs1: SUCCESS (1.981s) [224.927318] Starting dynamic subtest: vecs0 [226.902627] Dynamic subtest vecs0: SUCCESS (1.982s) [226.914108] Starting dynamic subtest: ccs0 [227.574740] Dynamic subtest ccs0: SUCCESS (0.671s) [227.577748] Subtest render-node-busy-idle: SUCCESS (7.159s) [227.658939] [039/133] (832s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [227.765351] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [227.769425] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [227.858819] [040/133] (832s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier) [227.958190] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier [227.962235] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s) [228.032498] [041/133] (832s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [228.142157] Starting subtest: cursorB-vs-flipB-varying-size [228.146672] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [228.300583] [042/133] (831s left) syncobj_eventfd (binary-wait) [228.357829] Starting subtest: binary-wait [228.367014] Subtest binary-wait: SUCCESS (0.010s) [228.438375] [043/133] (831s left) gem_mmap_offset (partial-mmap) [228.500172] Starting subtest: partial-mmap [228.502658] Starting dynamic subtest: smem0 [228.504878] Dynamic subtest smem0: SUCCESS (0.005s) [228.506751] Subtest partial-mmap: SUCCESS (0.005s) [228.629128] [044/133] (831s left) gem_softpin (reverse) [228.690278] Starting subtest: reverse [228.694929] Subtest reverse: SUCCESS (0.005s) [228.827342] [045/133] (831s left) gem_exec_params (cliprects-invalid) [228.887465] Starting subtest: cliprects-invalid [228.889113] Subtest cliprects-invalid: SUCCESS (0.000s) [228.974492] [046/133] (831s left) gem_ctx_isolation (preservation-reset) [229.146696] Starting subtest: preservation-reset [229.148975] Starting dynamic subtest: rcs0 [229.400385] Dynamic subtest rcs0: SUCCESS (0.257s) [229.413322] Starting dynamic subtest: bcs0 [229.702778] Dynamic subtest bcs0: SUCCESS (0.301s) [229.711805] Starting dynamic subtest: vcs0 [229.999377] Dynamic subtest vcs0: SUCCESS (0.296s) [230.010899] Starting dynamic subtest: vcs1 [231.195339] Dynamic subtest vcs1: SUCCESS (1.195s) [231.204745] Starting dynamic subtest: vecs0 [233.138277] Dynamic subtest vecs0: SUCCESS (1.941s) [233.148100] Starting dynamic subtest: ccs0 [235.193454] Dynamic subtest ccs0: SUCCESS (2.055s) [235.196305] Subtest preservation-reset: SUCCESS (6.053s) [235.319420] [047/133] (825s left) gem_pxp (hw-rejects-pxp-context) [235.440208] Starting subtest: hw-rejects-pxp-context [235.444724] Subtest hw-rejects-pxp-context: SKIP (0.000s) [235.570416] [048/133] (824s left) kms_getfb (getfb-reject-nv12) [235.661847] Starting subtest: getfb-reject-nv12 [235.664169] Subtest getfb-reject-nv12: SUCCESS (0.001s) [235.749193] [049/133] (824s left) drm_read (short-buffer-nonblock) [235.903810] Starting subtest: short-buffer-nonblock [235.906286] Subtest short-buffer-nonblock: SUCCESS (0.000s) [236.021233] [050/133] (824s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [236.079152] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [236.080954] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [236.174271] [051/133] (824s left) kms_big_fb (linear-32bpp-rotate-90) [236.266173] Starting subtest: linear-32bpp-rotate-90 [236.285327] Subtest linear-32bpp-rotate-90: SKIP (0.019s) [236.384572] [052/133] (824s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [236.436492] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [236.438508] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [236.532536] [053/133] (824s left) kms_selftest (drm_plane_helper) [236.574218] Starting subtest: drm_plane_helper [236.609018] Starting dynamic subtest: drm_test_check_plane_state [236.697648] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.090s) [236.705682] Starting dynamic subtest: drm_test_check_invalid_plane_state [236.803403] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.105s) [236.805683] Subtest drm_plane_helper: SUCCESS (0.231s) [236.971587] [054/133] (823s left) sw_sync (alloc_merge_fence) [237.012583] Starting subtest: alloc_merge_fence [237.014818] Subtest alloc_merge_fence: SUCCESS (0.000s) [237.064852] [055/133] (823s left) prime_vgem (basic-fence-blt) [237.128279] Starting subtest: basic-fence-blt [237.203327] Subtest basic-fence-blt: SUCCESS (0.077s) [237.333177] [056/133] (823s left) kms_big_fb (y-tiled-16bpp-rotate-180) [237.429686] Starting subtest: y-tiled-16bpp-rotate-180 [237.433655] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [237.524509] [057/133] (823s left) api_intel_bb (intel-bb-blit-x) [237.580791] Starting subtest: intel-bb-blit-x [241.304844] Subtest intel-bb-blit-x: SUCCESS (3.724s) [241.408976] [058/133] (819s left) kms_scaling_modes (scaling-mode-full-aspect) [241.509648] Starting subtest: scaling-mode-full-aspect [241.512230] Starting dynamic subtest: pipe-A-eDP-1 [241.602270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.092s) [241.611621] Starting dynamic subtest: pipe-B-eDP-1 [242.789231] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.184s) [242.798118] Starting dynamic subtest: pipe-C-eDP-1 [243.897089] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s) [243.906269] Starting dynamic subtest: pipe-D-eDP-1 [245.032197] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [245.034450] Subtest scaling-mode-full-aspect: SUCCESS (3.524s) [246.189621] [059/133] (814s left) kms_flip (plain-flip-ts-check) [246.299536] Starting subtest: plain-flip-ts-check [246.301886] Starting dynamic subtest: A-eDP1 [255.186698] Dynamic subtest A-eDP1: SUCCESS (8.889s) [255.197470] Starting dynamic subtest: B-eDP1 [264.020562] Dynamic subtest B-eDP1: SUCCESS (8.831s) [264.031255] Starting dynamic subtest: C-eDP1 [272.838794] Dynamic subtest C-eDP1: SUCCESS (8.817s) [272.851171] Starting dynamic subtest: D-eDP1 [281.669901] Dynamic subtest D-eDP1: SUCCESS (8.828s) [281.674868] Subtest plain-flip-ts-check: SUCCESS (35.378s) [282.850918] [060/133] (778s left) kms_cursor_edge_walk (64x64-top-bottom) [282.946212] Starting subtest: 64x64-top-bottom [282.948616] Starting dynamic subtest: pipe-A-eDP-1 [286.406591] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.460s) [286.417155] Starting dynamic subtest: pipe-D-eDP-1 [289.550406] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.145s) [289.552704] Subtest 64x64-top-bottom: SUCCESS (6.607s) [290.348948] [061/133] (770s left) api_intel_allocator (reopen-fork) [290.399817] Starting subtest: reopen-fork [293.649777] Subtest reopen-fork: SUCCESS (3.249s) [293.728098] [062/133] (767s left) kms_busy (extended-pageflip-hang-newfb) [293.820741] Starting subtest: extended-pageflip-hang-newfb [293.822925] Starting dynamic subtest: pipe-A [319.661680] Dynamic subtest pipe-A: SUCCESS (25.839s) [319.671901] Starting dynamic subtest: pipe-D [344.688841] Dynamic subtest pipe-D: SUCCESS (25.024s) [344.691648] Subtest extended-pageflip-hang-newfb: SUCCESS (50.867s) [345.506905] [063/133] (715s left) kms_psr (psr-basic) [345.603921] Starting subtest: psr-basic [345.606221] Starting dynamic subtest: eDP-1 [347.198403] Dynamic subtest eDP-1: SUCCESS (1.595s) [347.200775] Subtest psr-basic: SUCCESS (1.597s) [348.091112] [064/133] (713s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [348.209254] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [348.213559] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [348.301709] [065/133] (712s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [348.558931] Starting subtest: parallel-dmabuf-import-out-fence [349.792648] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.233s) [349.893372] [066/133] (711s left) kms_addfb_basic (unused-pitches) [349.960447] Starting subtest: unused-pitches [349.962392] Subtest unused-pitches: SUCCESS (0.000s) [350.095287] [067/133] (711s left) i915_drm_fdinfo (memory-info-idle) [350.142736] Starting subtest: memory-info-idle [350.145174] Starting dynamic subtest: smem0 [350.202066] Dynamic subtest smem0: SUCCESS (0.061s) [350.204835] Subtest memory-info-idle: SUCCESS (0.061s) [350.275838] [068/133] (711s left) gem_busy (busy) [350.360613] Starting subtest: busy [350.363069] Starting dynamic subtest: all-engines [350.395445] Dynamic subtest all-engines: SUCCESS (0.034s) [350.405599] Starting dynamic subtest: rcs0 [351.900825] Dynamic subtest rcs0: SUCCESS (1.503s) [351.911970] Starting dynamic subtest: bcs0 [351.941511] Dynamic subtest bcs0: SUCCESS (0.038s) [351.951236] Starting dynamic subtest: vcs0 [351.979798] Dynamic subtest vcs0: SUCCESS (0.038s) [351.988573] Starting dynamic subtest: vcs1 [353.948775] Dynamic subtest vcs1: SUCCESS (1.964s) [353.963899] Starting dynamic subtest: vecs0 [355.932109] Dynamic subtest vecs0: SUCCESS (1.983s) [355.943377] Starting dynamic subtest: ccs0 [357.916932] Dynamic subtest ccs0: SUCCESS (1.984s) [357.919187] Subtest busy: SUCCESS (7.554s) [358.285469] [069/133] (703s left) gem_ctx_param (non-root-set) [358.340926] Starting subtest: non-root-set [358.357216] Subtest non-root-set: SUCCESS (0.017s) [358.454225] [070/133] (702s left) kms_pm_rpm (system-suspend-idle) [360.083804] Starting subtest: system-suspend-idle [379.963495] Subtest system-suspend-idle: SUCCESS (4.404s) [380.334814] [071/133] (681s left) kms_pipe_crc_basic (read-crc-frame-sequence) [380.443801] Starting subtest: read-crc-frame-sequence [380.446124] Starting dynamic subtest: pipe-A-eDP-1 [381.149193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s) [381.160737] Starting dynamic subtest: pipe-B-eDP-1 [382.502131] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.350s) [382.512715] Starting dynamic subtest: pipe-C-eDP-1 [383.789839] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.285s) [383.799672] Starting dynamic subtest: pipe-D-eDP-1 [385.144186] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s) [385.146468] Subtest read-crc-frame-sequence: SUCCESS (4.695s) [385.955709] [072/133] (675s left) gem_exec_params (batch-first) [386.010596] Starting subtest: batch-first [386.016362] Subtest batch-first: SUCCESS (0.006s) [386.145167] [073/133] (675s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [386.238403] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [386.240587] Starting dynamic subtest: pipe-A-default-mode [387.412232] Dynamic subtest pipe-A-default-mode: SKIP (1.170s) [387.416371] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.172s) [387.551007] [074/133] (673s left) gem_mmap_offset (pf-nonblock) [387.607592] Starting subtest: pf-nonblock [387.612226] Subtest pf-nonblock: SUCCESS (0.005s) [387.740603] [075/133] (673s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt) [387.840588] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt [387.844971] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [387.950873] [076/133] (673s left) gem_mmap_wc (read) [387.995933] Subtest read: SKIP (0.000s) [388.056115] [077/133] (673s left) syncobj_timeline (etime-multi-wait-all-submitted) [388.109862] Starting subtest: etime-multi-wait-all-submitted [388.211480] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s) [388.287584] [078/133] (673s left) kms_flip (dpms-off-confusion) [388.383974] Starting subtest: dpms-off-confusion [388.386179] Starting dynamic subtest: A-eDP1 [397.094290] Dynamic subtest A-eDP1: SUCCESS (8.705s) [397.105458] Starting dynamic subtest: B-eDP1 [405.749170] Dynamic subtest B-eDP1: SUCCESS (8.651s) [405.764048] Starting dynamic subtest: C-eDP1 [414.374446] Dynamic subtest C-eDP1: SUCCESS (8.622s) [414.388312] Starting dynamic subtest: D-eDP1 [423.101312] Dynamic subtest D-eDP1: SUCCESS (8.724s) [423.106196] Subtest dpms-off-confusion: SUCCESS (34.715s) [424.282675] [079/133] (637s left) gem_ctx_persistence (legacy-engines-mixed-process) [424.357968] Starting subtest: legacy-engines-mixed-process [424.360299] Starting dynamic subtest: render [426.380359] Dynamic subtest render: SUCCESS (2.021s) [426.391055] Starting dynamic subtest: bsd1 [428.365322] Dynamic subtest bsd1: SUCCESS (1.983s) [428.376942] Starting dynamic subtest: bsd2 [430.356505] Dynamic subtest bsd2: SUCCESS (1.989s) [430.368297] Starting dynamic subtest: blt [432.324339] Dynamic subtest blt: SUCCESS (1.966s) [432.336569] Starting dynamic subtest: vebox [434.358640] Dynamic subtest vebox: SUCCESS (2.032s) [434.361056] Subtest legacy-engines-mixed-process: SUCCESS (9.999s) [434.493244] [080/133] (627s left) gem_render_copy_redux (normal) [434.554162] Starting subtest: normal [434.979454] Subtest normal: SUCCESS (0.424s) [435.108861] [081/133] (626s left) gen9_exec_parse (bb-secure) [435.170244] Subtest bb-secure: SKIP (0.000s) [435.240123] [082/133] (626s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf) [435.337043] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf [435.341111] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [435.420231] [083/133] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [435.523426] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [435.527014] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [435.631095] [084/133] (626s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [435.735133] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [442.561571] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.827s) [442.677291] [085/133] (619s left) kms_cursor_crc (cursor-offscreen-512x170) [442.999984] Starting subtest: cursor-offscreen-512x170 [443.004316] Subtest cursor-offscreen-512x170: SKIP (0.001s) [443.154845] [086/133] (618s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [443.222726] Starting subtest: invalid-bsd2-flag-on-vebox [443.225178] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [443.329341] [087/133] (618s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [443.424064] Starting subtest: psr-rgb101010-draw-mmap-wc [450.365439] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.943s) [450.501822] [088/133] (611s left) i915_pm_freq_api (freq-reset) [450.566074] Starting subtest: freq-reset [450.568568] Starting dynamic subtest: gt0 [450.754500] Dynamic subtest gt0: SUCCESS (0.188s) [450.763855] Starting dynamic subtest: gt1 [450.930283] Dynamic subtest gt1: SUCCESS (0.173s) [450.933479] Subtest freq-reset: SUCCESS (0.363s) [451.005004] [089/133] (611s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [451.099448] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [451.101320] Starting dynamic subtest: pipe-A-eDP-1 [451.947469] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.839s) [451.958339] Starting dynamic subtest: pipe-B-eDP-1 [453.556876] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.608s) [453.567556] Starting dynamic subtest: pipe-C-eDP-1 [455.104349] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.546s) [455.115523] Starting dynamic subtest: pipe-D-eDP-1 [456.577463] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.473s) [456.579733] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.471s) [457.766003] [090/133] (604s left) syncobj_wait (multi-wait-all-submitted) [457.818887] Starting subtest: multi-wait-all-submitted [457.924308] Subtest multi-wait-all-submitted: SUCCESS (0.105s) [457.998854] [091/133] (604s left) kms_vblank (wait-forked-busy) [458.088076] Starting subtest: wait-forked-busy [458.090259] Starting dynamic subtest: pipe-A-eDP-1 [459.976997] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s) [459.991982] Starting dynamic subtest: pipe-D-eDP-1 [462.526392] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.541s) [462.528709] Subtest wait-forked-busy: SUCCESS (4.437s) [463.325138] [092/133] (598s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [463.418687] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [464.532373] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.114s) [464.687017] [093/133] (597s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [464.785708] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [464.787326] Starting dynamic subtest: pipe-A-eDP-1 [465.998864] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.214s) [466.009350] Starting dynamic subtest: pipe-B-eDP-1 [468.217654] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.217s) [468.227647] Starting dynamic subtest: pipe-C-eDP-1 [470.450881] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.231s) [470.462593] Starting dynamic subtest: pipe-D-eDP-1 [472.721569] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.269s) [472.723959] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (7.936s) [473.865503] [094/133] (588s left) kms_cursor_legacy (cursor-vs-flip-toggle) [473.995130] Starting subtest: cursor-vs-flip-toggle [504.896348] Subtest cursor-vs-flip-toggle: SUCCESS (30.902s) [505.687016] [095/133] (556s left) kms_pm_rpm (cursor) [507.521507] Starting subtest: cursor [507.526330] Subtest cursor: SKIP (0.000s) [507.933203] [096/133] (554s left) gem_ctx_engines (none) [507.995895] Starting subtest: none [507.998177] Subtest none: SUCCESS (0.001s) [508.181870] [097/133] (554s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [508.317000] Starting subtest: 2x-long-flip-vs-cursor-legacy [508.321611] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [508.463892] [098/133] (554s left) kms_psr (fbc-psr-sprite-plane-move) [508.552532] Starting subtest: fbc-psr-sprite-plane-move [508.554761] Starting dynamic subtest: eDP-1 [508.558825] Dynamic subtest eDP-1: SKIP (0.000s) [508.562954] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [508.625784] [099/133] (554s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [508.725656] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [508.727935] Starting dynamic subtest: pipe-A-eDP-1 [508.750795] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [508.764361] Starting dynamic subtest: pipe-B-eDP-1 [508.786120] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [508.794963] Starting dynamic subtest: pipe-C-eDP-1 [508.816764] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [508.825683] Starting dynamic subtest: pipe-D-eDP-1 [508.847366] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [508.851725] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [510.968771] [100/133] (551s left) gem_wait (await) [511.042694] Starting subtest: await [511.045008] Starting dynamic subtest: all-engines [512.122286] Dynamic subtest all-engines: SUCCESS (1.078s) [512.139339] Starting dynamic subtest: rcs0 [513.180158] Dynamic subtest rcs0: SUCCESS (1.056s) [513.201283] Starting dynamic subtest: bcs0 [514.240165] Dynamic subtest bcs0: SUCCESS (1.058s) [514.256721] Starting dynamic subtest: vcs0 [515.293835] Dynamic subtest vcs0: SUCCESS (1.052s) [515.315813] Starting dynamic subtest: vcs1 [516.347596] Dynamic subtest vcs1: SUCCESS (1.051s) [516.364292] Starting dynamic subtest: vecs0 [517.402765] Dynamic subtest vecs0: SUCCESS (1.053s) [517.420666] Starting dynamic subtest: ccs0 [518.459948] Dynamic subtest ccs0: SUCCESS (1.054s) [518.462503] Subtest await: SUCCESS (7.418s) [518.658041] [101/133] (544s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [518.764052] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [518.766128] Starting dynamic subtest: pipe-A-eDP-1 [518.820607] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [518.830541] Starting dynamic subtest: pipe-B-eDP-1 [518.885628] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [518.899005] Starting dynamic subtest: pipe-C-eDP-1 [518.955430] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [518.966767] Starting dynamic subtest: pipe-D-eDP-1 [519.025092] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [519.029234] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s) [521.031614] [102/133] (541s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [521.132030] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [521.136295] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [521.225181] [103/133] (541s left) syncobj_wait (invalid-reset-illegal-handle) [521.289575] Starting subtest: invalid-reset-illegal-handle [521.291770] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [521.392450] [104/133] (541s left) kms_big_fb (4-tiled-8bpp-rotate-90) [521.490069] Starting subtest: 4-tiled-8bpp-rotate-90 [521.511283] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s) [521.627255] [105/133] (541s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [521.682364] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [521.684842] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [521.786328] [106/133] (541s left) kms_plane (plane-position-hole) [521.880747] Starting subtest: plane-position-hole [522.405386] Starting dynamic subtest: pipe-A-plane-1 [523.742793] Dynamic subtest pipe-A-plane-1: SUCCESS (1.340s) [523.754365] Starting dynamic subtest: pipe-A-plane-2 [525.060929] Dynamic subtest pipe-A-plane-2: SUCCESS (1.316s) [525.071150] Starting dynamic subtest: pipe-A-plane-3 [526.375277] Dynamic subtest pipe-A-plane-3: SUCCESS (1.310s) [526.386137] Starting dynamic subtest: pipe-A-plane-4 [527.679384] Dynamic subtest pipe-A-plane-4: SUCCESS (1.305s) [527.690108] Starting dynamic subtest: pipe-A-plane-5 [527.721051] Dynamic subtest pipe-A-plane-5: SUCCESS (0.040s) [528.849675] Starting dynamic subtest: pipe-B-plane-1 [530.178479] Dynamic subtest pipe-B-plane-1: SUCCESS (1.337s) [530.188264] Starting dynamic subtest: pipe-B-plane-2 [531.512272] Dynamic subtest pipe-B-plane-2: SUCCESS (1.333s) [531.522158] Starting dynamic subtest: pipe-B-plane-3 [532.869042] Dynamic subtest pipe-B-plane-3: SUCCESS (1.357s) [532.879646] Starting dynamic subtest: pipe-B-plane-4 [534.132618] Dynamic subtest pipe-B-plane-4: SUCCESS (1.263s) [534.143775] Starting dynamic subtest: pipe-B-plane-5 [534.163615] Dynamic subtest pipe-B-plane-5: SUCCESS (0.028s) [534.166078] Subtest plane-position-hole: SUCCESS (12.280s) [534.954505] [107/133] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [535.055729] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [542.334003] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.279s) [542.445543] [108/133] (520s left) vgem_basic (bad-pad) [542.488157] Starting subtest: bad-pad [542.490297] Subtest bad-pad: SUCCESS (0.000s) [542.547170] [109/133] (520s left) kms_async_flips (test-time-stamp-atomic) [542.632102] Starting subtest: test-time-stamp-atomic [543.015747] Starting dynamic subtest: pipe-A-eDP-1 [543.865477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s) [544.264085] Starting dynamic subtest: pipe-B-eDP-1 [545.015471] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s) [545.409380] Starting dynamic subtest: pipe-C-eDP-1 [546.167031] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s) [546.537042] Starting dynamic subtest: pipe-D-eDP-1 [547.293987] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s) [547.296334] Subtest test-time-stamp-atomic: SUCCESS (4.663s) [548.455665] [110/133] (514s left) kms_content_protection (dp-mst-lic-type-1) [548.589763] Starting subtest: dp-mst-lic-type-1 [548.594405] Subtest dp-mst-lic-type-1: SKIP (0.000s) [548.698084] [111/133] (514s left) gem_mmap_gtt (medium-copy) [548.756006] Subtest medium-copy: SKIP (0.000s) [548.819169] [112/133] (514s left) kms_chamelium_edid (dp-edid-read) [549.213510] Subtest dp-edid-read: SKIP (0.000s) [550.073225] [113/133] (513s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [550.161174] Starting subtest: primary-yf-tiled-reflect-x-270 [550.165474] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [550.241439] [114/133] (513s left) sw_sync (sync_busy_fork) [550.274451] Starting subtest: sync_busy_fork [551.282069] Subtest sync_busy_fork: SUCCESS (1.011s) [551.352759] [115/133] (511s left) kms_psr (pr-suspend) [551.456143] Starting subtest: pr-suspend [551.460103] Subtest pr-suspend: SKIP (0.000s) [551.529499] [116/133] (511s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [551.627534] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [551.631511] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [551.723986] [117/133] (511s left) i915_pm_freq_mult (media-freq) [551.767496] Starting subtest: media-freq [551.769975] Starting dynamic subtest: gt0 [551.774350] Dynamic subtest gt0: SKIP (0.000s) [551.784595] Starting dynamic subtest: gt1 [551.788752] Dynamic subtest gt1: SKIP (0.000s) [551.792962] Subtest media-freq: SKIP (0.002s) [551.867318] [118/133] (511s left) kms_joiner (invalid-modeset-big-joiner) [551.954997] Starting subtest: invalid-modeset-big-joiner [551.959001] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [552.027004] [119/133] (511s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render) [552.125533] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render [552.129497] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [552.220310] [120/133] (511s left) gem_exec_reloc (basic-gtt-wc-noreloc) [552.283391] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [552.356373] [121/133] (511s left) kms_psr (fbc-pr-cursor-render) [552.441989] Starting subtest: fbc-pr-cursor-render [552.445624] Subtest fbc-pr-cursor-render: SKIP (0.000s) [552.513319] [122/133] (511s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [552.628514] Starting subtest: cursorB-vs-flipB-legacy [552.632466] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s) [552.769518] [123/133] (510s left) kms_cursor_crc (cursor-random-256x256) [553.011000] Starting subtest: cursor-random-256x256 [553.015173] Starting dynamic subtest: pipe-A-eDP-1 [556.356479] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.340s) [556.386404] Starting dynamic subtest: pipe-D-eDP-1 [560.376193] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.998s) [560.378578] Subtest cursor-random-256x256: SUCCESS (7.364s) [561.267020] [124/133] (502s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [561.365736] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [561.370125] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [561.453824] [125/133] (502s left) perf_pmu (busy-accuracy-98) [561.492196] Starting subtest: busy-accuracy-98 [561.494492] Starting dynamic subtest: rcs0 [564.531613] Dynamic subtest rcs0: SUCCESS (3.038s) [564.543069] Starting dynamic subtest: bcs0 [567.588989] Dynamic subtest bcs0: SUCCESS (3.055s) [567.600585] Starting dynamic subtest: vcs0 [570.633247] Dynamic subtest vcs0: SUCCESS (3.041s) [570.644635] Starting dynamic subtest: vcs1 [573.681632] Dynamic subtest vcs1: SUCCESS (3.043s) [573.693632] Starting dynamic subtest: vecs0 [576.724373] Dynamic subtest vecs0: SUCCESS (3.041s) [576.737210] Starting dynamic subtest: ccs0 [579.783916] Dynamic subtest ccs0: SUCCESS (3.056s) [579.786448] Subtest busy-accuracy-98: SUCCESS (18.290s) [579.938606] [126/133] (483s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [580.044980] Starting subtest: psr-1p-primscrn-spr-indfb-move [587.574682] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.531s) [587.700867] [127/133] (476s left) gem_mmap (big-bo) [587.755653] Subtest big-bo: SKIP (0.000s) [587.819894] [128/133] (476s left) gem_ctx_sseu (engines) [587.880560] Subtest engines: SKIP (0.000s) [587.947496] [129/133] (475s left) kms_lease (empty-lease) [588.037043] Starting subtest: empty-lease [588.039279] Starting dynamic subtest: pipe-A-eDP-1 [588.041569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [588.054004] Starting dynamic subtest: pipe-B-eDP-1 [588.055957] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [588.065211] Starting dynamic subtest: pipe-C-eDP-1 [588.067101] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [588.076255] Starting dynamic subtest: pipe-D-eDP-1 [588.078164] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [588.080042] Subtest empty-lease: SUCCESS (0.009s) [588.143870] [130/133] (475s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [588.232643] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [588.234528] Starting dynamic subtest: pipe-A-eDP-1 [604.924695] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.180s) [604.935518] Starting dynamic subtest: pipe-B-eDP-1 [621.909365] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.348s) [621.919972] Starting dynamic subtest: pipe-C-eDP-1 [638.902391] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.346s) [638.917883] Starting dynamic subtest: pipe-D-eDP-1 [655.896071] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.351s) [655.898591] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.230s) [657.053030] [131/133] (406s left) gem_softpin (evict-active) [657.114840] Starting subtest: evict-active [657.120664] Subtest evict-active: SUCCESS (0.006s) [657.241255] [132/133] (406s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [657.303401] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [657.366213] [133/133] (406s left) syncobj_wait (wait-all-for-submit-delayed-submit) [657.427658] Starting subtest: wait-all-for-submit-delayed-submit [657.529907] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [657.605189] Closing watchdogs results: parsing output: 0/ for test: kms_chamelium_hpd results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_exec_schedule results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: gem_exec_reloc results: parsing output: 6/ for test: gem_exec_fence results: parsing output: 7/ for test: kms_psr2_sf results: parsing output: 8/ for test: gem_exec_balancer results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: gem_ringfill results: parsing output: 11/ for test: sw_sync results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: prime_self_import results: parsing output: 14/ for test: syncobj_basic results: parsing output: 15/ for test: gem_ppgtt results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_exec_store results: parsing output: 19/ for test: i915_suspend results: parsing output: 20/ for test: kms_color results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: core_hotunplug results: parsing output: 23/ for test: kms_plane results: parsing output: 24/ for test: gem_mmap_wc results: parsing output: 25/ for test: kms_plane_scaling results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_draw_crc results: parsing output: 28/ for test: gem_exec_params results: parsing output: 29/ for test: kms_cursor_legacy results: parsing output: 30/ for test: kms_addfb_basic results: parsing output: 31/ for test: kms_setmode results: parsing output: 32/ for test: kms_dp_link_training results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: gem_lmem_swapping results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: gem_exec_schedule results: parsing output: 37/ for test: perf_pmu results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_plane results: parsing output: 40/ for test: kms_cursor_legacy results: parsing output: 41/ for test: syncobj_eventfd results: parsing output: 42/ for test: gem_mmap_offset results: parsing output: 43/ for test: gem_softpin results: parsing output: 44/ for test: gem_exec_params results: parsing output: 45/ for test: gem_ctx_isolation results: parsing output: 46/ for test: gem_pxp results: parsing output: 47/ for test: kms_getfb results: parsing output: 48/ for test: drm_read results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: kms_selftest results: parsing output: 53/ for test: sw_sync results: parsing output: 54/ for test: prime_vgem results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: api_intel_bb results: parsing output: 57/ for test: kms_scaling_modes results: parsing output: 58/ for test: kms_flip results: parsing output: 59/ for test: kms_cursor_edge_walk results: parsing output: 60/ for test: api_intel_allocator results: parsing output: 61/ for test: kms_busy results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_exec_balancer results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: i915_drm_fdinfo results: parsing output: 67/ for test: gem_busy results: parsing output: 68/ for test: gem_ctx_param results: parsing output: 69/ for test: kms_pm_rpm results: parsing output: 70/ for test: kms_pipe_crc_basic results: parsing output: 71/ for test: gem_exec_params results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_mmap_offset results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_mmap_wc results: parsing output: 76/ for test: syncobj_timeline results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: gem_ctx_persistence results: parsing output: 79/ for test: gem_render_copy_redux results: parsing output: 80/ for test: gen9_exec_parse results: parsing output: 81/ for test: kms_psr2_sf results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: gem_exec_params results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: i915_pm_freq_api results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: kms_vblank results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: kms_ccs results: parsing output: 93/ for test: kms_cursor_legacy results: parsing output: 94/ for test: kms_pm_rpm results: parsing output: 95/ for test: gem_ctx_engines results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: gem_wait results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: syncobj_wait results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: syncobj_wait results: parsing output: 105/ for test: kms_plane results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: vgem_basic results: parsing output: 108/ for test: kms_async_flips results: parsing output: 109/ for test: kms_content_protection results: parsing output: 110/ for test: gem_mmap_gtt results: parsing output: 111/ for test: kms_chamelium_edid results: parsing output: 112/ for test: kms_rotation_crc results: parsing output: 113/ for test: sw_sync results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: i915_pm_freq_mult results: parsing output: 117/ for test: kms_joiner results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_exec_reloc results: parsing output: 120/ for test: kms_psr results: parsing output: 121/ for test: kms_cursor_legacy results: parsing output: 122/ for test: kms_cursor_crc results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: perf_pmu results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_mmap results: parsing output: 127/ for test: gem_ctx_sseu results: parsing output: 128/ for test: kms_lease results: parsing output: 129/ for test: kms_ccs results: parsing output: 130/ for test: gem_softpin results: parsing output: 131/ for test: gem_mmap_gtt results: parsing output: 132/ for test: syncobj_wait Done.