[62.804895] Initializing watchdogs
[62.804941]   /dev/watchdog0
[62.818614] [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]
[62.823248] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.825376] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.828566] [001/133] (960s left) kms_color (ctm-0-25)
[62.945865] Starting subtest: ctm-0-25
[62.948113] Starting dynamic subtest: pipe-A-eDP-1
[66.553544] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.602s)
[66.561568] Starting dynamic subtest: pipe-B-eDP-1
[70.738704] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.180s)
[70.747127] Starting dynamic subtest: pipe-C-eDP-1
[74.691065] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.949s)
[74.699380] Starting dynamic subtest: pipe-D-eDP-1
[78.692089] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.999s)
[78.694471] Subtest ctm-0-25: SUCCESS (15.731s)
[79.544656] [002/133] (943s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[79.657671] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[79.661785] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[79.771263] [003/133] (943s left) gem_exec_balancer (noheartbeat)
[80.039753] Starting subtest: noheartbeat
[80.044387] Subtest noheartbeat: SKIP (0.000s)
[80.157653] [004/133] (943s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[80.283788] Starting subtest: cursorB-vs-flipB-atomic-transitions
[80.288312] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[80.436926] [005/133] (943s left) kms_busy (extended-pageflip-hang-oldfb)
[80.545529] Starting subtest: extended-pageflip-hang-oldfb
[80.547795] Starting dynamic subtest: pipe-A
[80.966516] Dynamic subtest pipe-A: SUCCESS (0.421s)
[80.974567] Starting dynamic subtest: pipe-D
[82.042079] Dynamic subtest pipe-D: SUCCESS (1.073s)
[82.044414] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.499s)
[82.887860] [006/133] (940s left) kms_draw_crc (draw-method-mmap-wc)
[82.987300] Starting subtest: draw-method-mmap-wc
[82.989190] Starting dynamic subtest: xrgb8888-untiled
[83.206889] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[83.214434] Starting dynamic subtest: rgb565-untiled
[83.429246] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[83.436863] Starting dynamic subtest: xrgb2101010-untiled
[83.640584] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[83.648182] Starting dynamic subtest: xbgr16161616f-untiled
[83.862293] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[83.868833] Starting dynamic subtest: xrgb8888-xtiled
[83.984699] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[83.992573] Starting dynamic subtest: rgb565-xtiled
[84.118026] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[84.125766] Starting dynamic subtest: xrgb2101010-xtiled
[84.251167] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[84.258187] Starting dynamic subtest: xbgr16161616f-xtiled
[84.384589] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[84.394061] Starting dynamic subtest: xrgb8888-4tiled
[84.551552] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[84.560472] Starting dynamic subtest: rgb565-4tiled
[84.695716] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[84.702488] Starting dynamic subtest: xrgb2101010-4tiled
[84.851278] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[84.858603] Starting dynamic subtest: xbgr16161616f-4tiled
[85.028981] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[85.030902] Subtest draw-method-mmap-wc: SUCCESS (2.044s)
[85.142271] [007/133] (938s left) kms_content_protection (uevent)
[85.282423] Starting subtest: uevent
[85.286296] Subtest uevent: SKIP (0.000s)
[85.437326] [008/133] (938s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[85.588591] Starting subtest: cursor-rapid-movement-32x32
[85.632058] Subtest cursor-rapid-movement-32x32: SKIP (0.039s)
[85.921443] [009/133] (937s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[85.979409] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[85.982891] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[86.170697] [010/133] (937s left) gem_exec_fence (syncobj-import)
[86.601206] Starting subtest: syncobj-import
[86.603584] Subtest syncobj-import: SUCCESS (0.005s)
[88.013349] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[88.016664] [011/133] (935s left) gem_exec_flush (basic-wb-pro-default)
[88.080793] Starting subtest: basic-wb-pro-default
[93.542499] Subtest basic-wb-pro-default: SUCCESS (5.462s)
[93.751815] [012/133] (929s left) gem_exec_schedule (preempt-other)
[93.824157] Starting subtest: preempt-other
[93.826219] Starting dynamic subtest: rcs0
[93.950158] Dynamic subtest rcs0: SUCCESS (0.131s)
[93.958407] Starting dynamic subtest: bcs0
[94.064525] Dynamic subtest bcs0: SUCCESS (0.114s)
[94.076064] Starting dynamic subtest: vcs0
[94.181919] Dynamic subtest vcs0: SUCCESS (0.117s)
[94.188558] Starting dynamic subtest: vcs1
[94.303110] Dynamic subtest vcs1: SUCCESS (0.120s)
[94.314276] Starting dynamic subtest: vecs0
[94.417271] Dynamic subtest vecs0: SUCCESS (0.114s)
[94.424752] Starting dynamic subtest: ccs0
[94.532270] Dynamic subtest ccs0: SUCCESS (0.115s)
[94.534401] Subtest preempt-other: SUCCESS (0.714s)
[95.052104] [013/133] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[95.153918] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[102.510702] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.358s)
[102.671573] [014/133] (921s left) gem_fence_thrash (bo-write-verify-threaded-y)
[102.702811] Starting subtest: bo-write-verify-threaded-y
[102.720531] Subtest bo-write-verify-threaded-y: SKIP (0.016s)
[102.784309] [015/133] (921s left) kms_addfb_basic (invalid-set-prop-any)
[102.835860] Starting subtest: invalid-set-prop-any
[102.838025] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[102.997413] [016/133] (920s left) gem_pxp (reject-modify-context-protection-off-3)
[103.123578] Starting subtest: reject-modify-context-protection-off-3
[103.126066] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[103.266397] [017/133] (920s left) gem_exec_schedule (fairslice-all)
[103.344983] Starting subtest: fairslice-all
[105.391565] Subtest fairslice-all: SUCCESS (2.052s)
[106.896805] [018/133] (917s left) kms_chamelium_edid (dp-mode-timings)
[107.294487] Subtest dp-mode-timings: SKIP (0.000s)
[108.132843] [019/133] (915s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[108.233974] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[108.235852] Starting dynamic subtest: pipe-A-eDP-1
[110.335052] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.101s)
[110.342247] Starting dynamic subtest: pipe-B-eDP-1
[112.479322] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.145s)
[112.486854] Starting dynamic subtest: pipe-C-eDP-1
[114.558501] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.077s)
[114.566159] Starting dynamic subtest: pipe-D-eDP-1
[116.549835] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.989s)
[116.552137] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.317s)
[117.803768] [020/133] (906s left) gem_ctx_param (invalid-get-no-zeromap)
[117.869517] Starting subtest: invalid-get-no-zeromap
[117.872057] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[117.995520] [021/133] (906s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[118.099348] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[125.449827] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.355s)
[125.606966] [022/133] (898s left) i915_pm_rps (thresholds-idle)
[125.684032] Starting subtest: thresholds-idle
[125.688072] Subtest thresholds-idle: SKIP (0.001s)
[125.802258] [023/133] (898s left) gem_close (many-handles-one-vma)
[125.863679] Starting subtest: many-handles-one-vma
[125.889595] Subtest many-handles-one-vma: SUCCESS (0.026s)
[126.051631] [024/133] (898s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[126.157130] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[126.161117] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[126.260897] [025/133] (897s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[126.663550] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[127.440451] [026/133] (896s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[127.547328] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[127.551612] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[127.652458] [027/133] (896s left) gem_mmap_offset (clear-via-pagefault)
[127.705067] Starting subtest: clear-via-pagefault
[127.706933] Starting dynamic subtest: smem0
[161.354122] Dynamic subtest smem0: SUCCESS (33.643s)
[161.356495] Subtest clear-via-pagefault: SUCCESS (33.645s)
[161.465847] [028/133] (862s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[161.538067] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[161.609418] [029/133] (862s left) kms_psr (pr-sprite-render)
[161.724989] Starting subtest: pr-sprite-render
[161.729451] Subtest pr-sprite-render: SKIP (0.000s)
[161.832696] [030/133] (862s left) gem_exec_reloc (basic-cpu-read-noreloc)
[161.893347] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[161.971136] [031/133] (862s left) kms_setmode (basic-clone-single-crtc)
[162.021070] Starting subtest: basic-clone-single-crtc
[162.027749] Subtest basic-clone-single-crtc: SKIP (0.000s)
[162.138762] [032/133] (862s left) gem_exec_alignment (pi-isolated)
[162.193656] Starting subtest: pi-isolated
[212.902544] Subtest pi-isolated: SUCCESS (50.704s)
[214.127856] [033/133] (810s left) gem_ctx_persistence (heartbeat-hang)
[214.224547] Starting subtest: heartbeat-hang
[214.228697] Subtest heartbeat-hang: SKIP (0.000s)
[214.343818] [034/133] (810s left) kms_display_modes (extended-mode-basic)
[214.453115] Starting subtest: extended-mode-basic
[214.457399] Subtest extended-mode-basic: SKIP (0.000s)
[214.497477] [035/133] (810s left) kms_plane (plane-position-hole)
[214.604931] Starting subtest: plane-position-hole
[215.100106] Starting dynamic subtest: pipe-A-plane-1
[216.434926] Dynamic subtest pipe-A-plane-1: SUCCESS (1.333s)
[216.443512] Starting dynamic subtest: pipe-A-plane-2
[217.752034] Dynamic subtest pipe-A-plane-2: SUCCESS (1.318s)
[217.763644] Starting dynamic subtest: pipe-A-plane-3
[219.006305] Dynamic subtest pipe-A-plane-3: SUCCESS (1.251s)
[219.014211] Starting dynamic subtest: pipe-A-plane-4
[220.301298] Dynamic subtest pipe-A-plane-4: SUCCESS (1.296s)
[220.309800] Starting dynamic subtest: pipe-A-plane-5
[220.330664] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[221.491684] Starting dynamic subtest: pipe-B-plane-1
[222.812043] Dynamic subtest pipe-B-plane-1: SUCCESS (1.326s)
[222.821154] Starting dynamic subtest: pipe-B-plane-2
[224.097838] Dynamic subtest pipe-B-plane-2: SUCCESS (1.285s)
[224.106802] Starting dynamic subtest: pipe-B-plane-3
[225.321649] Dynamic subtest pipe-B-plane-3: SUCCESS (1.225s)
[225.331388] Starting dynamic subtest: pipe-B-plane-4
[226.559814] Dynamic subtest pipe-B-plane-4: SUCCESS (1.235s)
[226.568348] Starting dynamic subtest: pipe-B-plane-5
[226.584123] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[226.586374] Subtest plane-position-hole: SUCCESS (11.978s)
[227.384392] [036/133] (797s left) kms_pm_backlight (bad-brightness)
[227.495411] Starting subtest: bad-brightness
[227.570792] Starting dynamic subtest: eDP-1
[227.857224] Dynamic subtest eDP-1: SUCCESS (0.285s)
[227.859610] Subtest bad-brightness: SUCCESS (0.362s)
[228.713214] [037/133] (796s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[228.768897] Starting subtest: multi-wait-available-unsubmitted-signaled
[228.771410] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[228.902899] [038/133] (795s left) kms_mmap_write_crc (main)
[228.994330] Starting subtest: main
[228.996290] Starting dynamic subtest: pipe-A-eDP-1
[232.354369] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.358s)
[232.356810] Subtest main: SUCCESS (3.360s)
[233.237910] [039/133] (791s left) gem_spin_batch (resubmit-new-all)
[233.306695] Starting subtest: resubmit-new-all
[233.308610] Starting dynamic subtest: rcs0
[233.316833] Dynamic subtest rcs0: SUCCESS (0.013s)
[233.326375] Starting dynamic subtest: bcs0
[233.328724] Dynamic subtest bcs0: SUCCESS (0.010s)
[233.336837] Starting dynamic subtest: vcs0
[233.339166] Dynamic subtest vcs0: SUCCESS (0.008s)
[233.346714] Starting dynamic subtest: vcs1
[233.348958] Dynamic subtest vcs1: SUCCESS (0.007s)
[233.363622] Starting dynamic subtest: vecs0
[233.365528] Dynamic subtest vecs0: SUCCESS (0.008s)
[233.372681] Starting dynamic subtest: ccs0
[233.374611] Dynamic subtest ccs0: SUCCESS (0.007s)
[233.376534] Subtest resubmit-new-all: SUCCESS (0.057s)
[234.961778] [040/133] (789s left) kms_flip (flip-vs-rmfb-interruptible)
[235.076353] Starting subtest: flip-vs-rmfb-interruptible
[235.079626] Starting dynamic subtest: A-eDP1
[243.714188] Dynamic subtest A-eDP1: SUCCESS (8.637s)
[243.722710] Starting dynamic subtest: B-eDP1
[252.344680] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[252.352968] Starting dynamic subtest: C-eDP1
[260.964993] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[260.974778] Starting dynamic subtest: D-eDP1
[269.604491] Dynamic subtest D-eDP1: SUCCESS (8.638s)
[269.609011] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.532s)
[270.819362] [041/133] (754s left) kms_rotation_crc (sprite-rotation-180)
[270.923504] Starting subtest: sprite-rotation-180
[277.684656] Subtest sprite-rotation-180: SUCCESS (6.764s)
[278.861421] [042/133] (746s left) gem_exec_alignment (single)
[278.928623] Starting subtest: single
[278.931074] Subtest single: SUCCESS (0.002s)
[279.099874] [043/133] (745s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[279.206892] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[280.163598] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.956s)
[280.320069] [044/133] (744s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[280.423261] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[287.819297] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.397s)
[287.969904] [045/133] (737s left) syncobj_wait (invalid-signal-zero-handles)
[288.024116] Starting subtest: invalid-signal-zero-handles
[288.026281] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[288.127203] [046/133] (736s left) kms_async_flips (alternate-sync-async-flip)
[288.216237] Starting subtest: alternate-sync-async-flip
[288.586491] Starting dynamic subtest: pipe-A-eDP-1
[291.348563] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.762s)
[291.730554] Starting dynamic subtest: pipe-B-eDP-1
[294.479068] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.756s)
[294.861949] Starting dynamic subtest: pipe-C-eDP-1
[297.602379] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.746s)
[297.965886] Starting dynamic subtest: pipe-D-eDP-1
[300.736705] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s)
[300.746415] Subtest alternate-sync-async-flip: SUCCESS (12.513s)
[301.954871] [047/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[302.140534] Starting subtest: fbcpsr-1p-rte
[309.116259] Subtest fbcpsr-1p-rte: SUCCESS (7.010s)
[309.264958] [048/133] (715s left) perf (gen12-group-exclusive-stream-ctx-handle)
[309.408388] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[309.430978] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[309.471486] [049/133] (715s left) gem_render_copy_redux (flink-interruptible)
[310.910046] Starting subtest: flink-interruptible
[311.606608] Subtest flink-interruptible: SUCCESS (0.699s)
[311.756198] [050/133] (713s left) gem_userptr_blits (probe)
[311.837182] Starting subtest: probe
[311.908303] Subtest probe: SUCCESS (0.071s)
[312.056116] [051/133] (713s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[312.165415] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[312.168997] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[312.289452] [052/133] (713s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[312.338550] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[312.381271] [053/133] (713s left) core_getclient (basic)
[312.441510] Starting subtest: basic
[312.443452] Subtest basic: SUCCESS (0.000s)
[312.573217] [054/133] (712s left) kms_cursor_crc (cursor-onscreen-128x128)
[312.792249] Starting subtest: cursor-onscreen-128x128
[312.797118] Starting dynamic subtest: pipe-A-eDP-1
[314.892664] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s)
[314.921028] Starting dynamic subtest: pipe-D-eDP-1
[317.683180] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[317.685422] Subtest cursor-onscreen-128x128: SUCCESS (4.889s)
[318.503198] [055/133] (706s left) kms_plane_lowres (tiling-y)
[318.612978] Starting subtest: tiling-y
[318.617405] Subtest tiling-y: SKIP (0.000s)
[318.693819] [056/133] (706s left) api_intel_allocator (gem-pool)
[318.743303] Starting subtest: gem-pool
[318.750103] Subtest gem-pool: SUCCESS (0.009s)
[318.898203] [057/133] (706s left) i915_drm_fdinfo (isolation)
[318.949327] Starting subtest: isolation
[318.951538] Starting dynamic subtest: rcs0
[318.971738] Dynamic subtest rcs0: SKIP (0.021s)
[318.981999] Starting dynamic subtest: bcs0
[318.994137] Dynamic subtest bcs0: SKIP (0.021s)
[319.004592] Starting dynamic subtest: vcs0
[319.009690] Dynamic subtest vcs0: SKIP (0.000s)
[319.023954] Starting dynamic subtest: vcs1
[319.028491] Dynamic subtest vcs1: SKIP (0.000s)
[319.038456] Starting dynamic subtest: vecs0
[319.043043] Dynamic subtest vecs0: SKIP (0.000s)
[319.052535] Starting dynamic subtest: ccs0
[319.056936] Dynamic subtest ccs0: SKIP (0.000s)
[319.062081] Subtest isolation: SKIP (0.047s)
[319.099582] [058/133] (706s left) gem_exec_parallel (basic)
[319.163077] Starting subtest: basic
[319.165410] Starting dynamic subtest: rcs0
[320.564639] Dynamic subtest rcs0: SUCCESS (1.401s)
[320.575683] Starting dynamic subtest: bcs0
[322.072558] Dynamic subtest bcs0: SUCCESS (1.506s)
[322.081421] Starting dynamic subtest: vcs0
[323.925267] Dynamic subtest vcs0: SUCCESS (1.850s)
[323.936281] Starting dynamic subtest: vcs1
[325.911259] Dynamic subtest vcs1: SUCCESS (1.983s)
[325.922588] Starting dynamic subtest: vecs0
[327.893092] Dynamic subtest vecs0: SUCCESS (1.979s)
[327.904951] Starting dynamic subtest: ccs0
[329.414941] Dynamic subtest ccs0: SUCCESS (1.521s)
[329.417692] Subtest basic: SUCCESS (10.253s)
[329.608988] [059/133] (696s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[329.709832] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[329.714297] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[329.831875] [060/133] (695s left) kms_getfb (getfb-handle-valid)
[329.935862] Starting subtest: getfb-handle-valid
[329.938226] Subtest getfb-handle-valid: SUCCESS (0.000s)
[330.072152] [061/133] (695s left) perf (invalid-remove-userspace-config)
[330.185028] Starting subtest: invalid-remove-userspace-config
[330.202414] Subtest invalid-remove-userspace-config: SUCCESS (0.016s)
[330.239999] [062/133] (695s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[330.355195] Starting subtest: pr-primary-plane-update-sf-dmg-area
[330.359922] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[330.437061] [063/133] (695s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[330.538297] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[330.542072] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[330.646932] [064/133] (695s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[330.746317] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[330.748221] Starting dynamic subtest: pipe-A-eDP-1
[330.772436] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[330.782960] Starting dynamic subtest: pipe-B-eDP-1
[330.802705] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[330.815921] Starting dynamic subtest: pipe-C-eDP-1
[330.833882] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[330.846230] Starting dynamic subtest: pipe-D-eDP-1
[330.865893] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[330.869535] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[332.987396] [065/133] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[333.098298] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[339.970571] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.873s)
[340.157210] [066/133] (685s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[340.252828] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[340.257048] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[340.389647] [067/133] (685s left) kms_pm_rpm (cursor-dpms)
[342.113509] Starting subtest: cursor-dpms
[342.118386] Subtest cursor-dpms: SKIP (0.000s)
[342.647121] [068/133] (683s left) gem_ccs (block-multicopy-inplace)
[342.716380] Starting subtest: block-multicopy-inplace
[342.720979] Subtest block-multicopy-inplace: SKIP (0.000s)
[342.841477] [069/133] (683s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[342.941667] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[342.945818] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[343.069081] [070/133] (683s left) kms_cursor_edge_walk (64x64-top-bottom)
[343.168293] Starting subtest: 64x64-top-bottom
[343.170634] Starting dynamic subtest: pipe-A-eDP-1
[346.588076] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.418s)
[346.601116] Starting dynamic subtest: pipe-D-eDP-1
[349.711141] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[349.713474] Subtest 64x64-top-bottom: SUCCESS (6.544s)
[350.536213] [071/133] (675s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[350.603149] Starting subtest: invalid-single-wait-all-unsubmitted
[350.605497] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[350.725688] [072/133] (675s left) gem_exec_capture (pi)
[350.783881] Starting subtest: pi
[350.786364] Starting dynamic subtest: rcs0
[355.138039] Dynamic subtest rcs0: SUCCESS (4.353s)
[355.148890] Starting dynamic subtest: bcs0
[359.209745] Dynamic subtest bcs0: SUCCESS (4.071s)
[359.220185] Starting dynamic subtest: vcs0
[363.262054] Dynamic subtest vcs0: SUCCESS (4.049s)
[363.272882] Starting dynamic subtest: vcs1
[367.246031] Dynamic subtest vcs1: SUCCESS (3.982s)
[367.257791] Starting dynamic subtest: vecs0
[371.251988] Dynamic subtest vecs0: SUCCESS (4.003s)
[371.263096] Starting dynamic subtest: ccs0
[375.378274] Dynamic subtest ccs0: SUCCESS (4.124s)
[375.381216] Subtest pi: SUCCESS (24.594s)
[375.473418] [073/133] (650s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[375.623906] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[375.628237] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[375.705853] [074/133] (650s left) kms_hdr (static-swap)
[375.801065] Starting subtest: static-swap
[375.807784] Subtest static-swap: SKIP (0.000s)
[375.882881] [075/133] (650s left) syncobj_wait (wait-for-submit-delayed-submit)
[375.952598] Starting subtest: wait-for-submit-delayed-submit
[376.057248] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[376.148775] [076/133] (650s left) kms_vrr (flip-dpms)
[376.235247] Starting subtest: flip-dpms
[376.241416] Subtest flip-dpms: SKIP (0.000s)
[376.332115] [077/133] (650s left) kms_big_fb (linear-addfb)
[376.431254] Starting subtest: linear-addfb
[376.433550] Subtest linear-addfb: SUCCESS (0.000s)
[376.550280] [078/133] (649s left) kms_addfb_basic (addfb25-bad-modifier)
[376.641134] Starting subtest: addfb25-bad-modifier
[376.643123] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[376.765671] [079/133] (649s left) kms_psr (psr-sprite-plane-onoff)
[376.854428] Starting subtest: psr-sprite-plane-onoff
[376.856656] Starting dynamic subtest: eDP-1
[378.647665] Dynamic subtest eDP-1: SUCCESS (1.791s)
[378.649963] Subtest psr-sprite-plane-onoff: SUCCESS (1.792s)
[379.472209] [080/133] (647s left) kms_psr (fbc-psr-sprite-plane-move)
[379.574911] Starting subtest: fbc-psr-sprite-plane-move
[379.577196] Starting dynamic subtest: eDP-1
[379.581552] Dynamic subtest eDP-1: SKIP (0.000s)
[379.585952] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[379.670366] [081/133] (646s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[379.778785] Starting subtest: fbcpsr-rgb101010-draw-blt
[386.533930] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.759s)
[386.684084] [082/133] (639s left) kms_prop_blob (invalid-get-prop)
[386.737054] Starting subtest: invalid-get-prop
[386.739289] Subtest invalid-get-prop: SUCCESS (0.000s)
[386.854898] [083/133] (639s left) sysfs_preempt_timeout (idempotent)
[386.912541] Starting subtest: idempotent
[386.914830] Starting dynamic subtest: vecs0
[386.917318] Dynamic subtest vecs0: SUCCESS (0.000s)
[386.926790] Starting dynamic subtest: ccs0
[386.928855] Dynamic subtest ccs0: SUCCESS (0.000s)
[386.936613] Starting dynamic subtest: vcs0
[386.938658] Dynamic subtest vcs0: SUCCESS (0.000s)
[386.946145] Starting dynamic subtest: bcs0
[386.948254] Dynamic subtest bcs0: SUCCESS (0.000s)
[386.955608] Starting dynamic subtest: rcs0
[386.957654] Dynamic subtest rcs0: SUCCESS (0.000s)
[386.965326] Starting dynamic subtest: vcs1
[386.967535] Dynamic subtest vcs1: SUCCESS (0.000s)
[386.969970] Subtest idempotent: SUCCESS (0.006s)
[387.040525] [084/133] (639s left) kms_psr (fbc-pr-primary-page-flip)
[387.142333] Starting subtest: fbc-pr-primary-page-flip
[387.146797] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[387.223660] [085/133] (639s left) gem_exec_reloc (basic-gtt-active)
[387.294781] Subtest basic-gtt-active: SKIP (0.000s)
[387.370586] [086/133] (639s left) kms_chamelium_color (ctm-0-75)
[387.462028] Subtest ctm-0-75: SKIP (0.000s)
[387.503156] [087/133] (639s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[387.600506] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[387.602458] Starting dynamic subtest: pipe-A-default-mode
[390.332067] Dynamic subtest pipe-A-default-mode: SUCCESS (2.730s)
[390.334392] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.731s)
[391.169322] [088/133] (635s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[391.272181] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[395.566350] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.297s)
[396.775802] [089/133] (630s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[396.885778] Starting subtest: psr-indfb-scaledprimary
[402.607981] Subtest psr-indfb-scaledprimary: SUCCESS (5.725s)
[402.775320] [090/133] (624s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[402.874400] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[402.878350] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[403.015755] [091/133] (623s left) syncobj_eventfd (timeline-wait)
[403.068601] Starting subtest: timeline-wait
[403.076725] Subtest timeline-wait: SUCCESS (0.010s)
[403.196384] [092/133] (623s left) gem_sync (basic-store-each)
[403.266376] Starting subtest: basic-store-each
[405.735245] Subtest basic-store-each: SUCCESS (2.479s)
[405.933527] [093/133] (621s left) core_getversion (all-cards)
[405.979459] Starting subtest: all-cards
[405.986596] Subtest all-cards: SUCCESS (0.010s)
[406.027734] [094/133] (621s left) gem_ctx_exec (basic-invalid-context)
[406.086258] Starting subtest: basic-invalid-context
[406.094363] Subtest basic-invalid-context: SUCCESS (0.008s)
[406.230476] [095/133] (620s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[406.323683] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[410.792400] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.472s)
[411.978372] [096/133] (615s left) kms_prop_blob (blob-multiple)
[412.040634] Starting subtest: blob-multiple
[412.042801] Subtest blob-multiple: SUCCESS (0.002s)
[412.165413] [097/133] (615s left) kms_invalid_mode (zero-clock)
[412.263415] Starting subtest: zero-clock
[412.265714] Starting dynamic subtest: pipe-A-eDP-1
[412.549840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[412.558808] Starting dynamic subtest: pipe-B-eDP-1
[412.561119] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[412.568395] Starting dynamic subtest: pipe-C-eDP-1
[412.570340] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[412.578141] Starting dynamic subtest: pipe-D-eDP-1
[412.580368] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[412.582658] Subtest zero-clock: SUCCESS (0.299s)
[413.399260] [098/133] (613s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[413.503066] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[413.505314] Starting dynamic subtest: pipe-A-default-mode
[416.252579] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s)
[416.254955] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.752s)
[417.114813] [099/133] (610s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[417.223163] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[417.225441] Starting dynamic subtest: pipe-A-eDP-1
[417.250641] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[417.260182] Starting dynamic subtest: pipe-B-eDP-1
[417.284978] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[417.293495] Starting dynamic subtest: pipe-C-eDP-1
[417.316111] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[417.323610] Starting dynamic subtest: pipe-D-eDP-1
[417.346773] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[417.350785] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.011s)
[419.569762] [100/133] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[419.685444] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[419.689948] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[419.823053] [101/133] (607s left) gem_tiled_wc
[419.950913] [102/133] (607s left) kms_universal_plane (universal-plane-sanity)
[420.052784] Starting subtest: universal-plane-sanity
[420.055115] Starting dynamic subtest: pipe-A-eDP-1
[420.647614] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s)
[420.656948] Starting dynamic subtest: pipe-B-eDP-1
[421.868501] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.219s)
[421.878519] Starting dynamic subtest: pipe-C-eDP-1
[423.081052] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[423.090093] Starting dynamic subtest: pipe-D-eDP-1
[424.322034] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[424.324530] Subtest universal-plane-sanity: SUCCESS (4.272s)
[425.196978] [103/133] (602s left) kms_plane_alpha_blend (alpha-opaque-fb)
[425.297354] Starting subtest: alpha-opaque-fb
[425.586392] Starting dynamic subtest: pipe-A-eDP-1
[426.203880] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.615s)
[426.211886] Starting dynamic subtest: pipe-D-eDP-1
[427.538823] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[427.541472] Subtest alpha-opaque-fb: SUCCESS (2.241s)
[428.363284] [104/133] (599s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[428.465880] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[428.470212] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[428.614345] [105/133] (598s left) kms_psr (psr2-primary-mmap-gtt)
[428.707546] Starting subtest: psr2-primary-mmap-gtt
[428.709787] Starting dynamic subtest: eDP-1
[430.154795] Dynamic subtest eDP-1: SKIP (1.445s)
[430.159787] Subtest psr2-primary-mmap-gtt: SKIP (1.447s)
[430.308553] [106/133] (597s left) gem_exec_schedule (semaphore-codependency)
[430.378610] Starting subtest: semaphore-codependency
[430.384121] Subtest semaphore-codependency: SUCCESS (0.013s)
[430.733862] [107/133] (596s left) gem_pread (bench)
[430.799744] Subtest bench: SKIP (0.000s)
[430.867438] [108/133] (596s left) drm_read (fault-buffer)
[431.031142] Starting subtest: fault-buffer
[431.033564] Subtest fault-buffer: SUCCESS (0.000s)
[431.196319] [109/133] (596s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[431.294621] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[431.298750] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[431.420340] [110/133] (596s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[431.525493] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[431.529787] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[431.640083] [111/133] (596s left) gem_softpin (evict-snoop)
[431.700037] Starting subtest: evict-snoop
[431.703513] Subtest evict-snoop: SKIP (0.000s)
[431.846496] [112/133] (595s left) kms_getfb (getfb-handle-not-fb)
[431.953561] Starting subtest: getfb-handle-not-fb
[431.955527] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[432.088590] [113/133] (595s left) syncobj_timeline (wait-all-delayed-signal)
[432.148375] Starting subtest: wait-all-delayed-signal
[432.252450] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[432.345777] [114/133] (595s left) kms_atomic (plane-invalid-params-fence)
[432.452425] Starting subtest: plane-invalid-params-fence
[432.454852] Starting dynamic subtest: pipe-A-eDP-1
[432.807558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[432.809863] Subtest plane-invalid-params-fence: SUCCESS (0.356s)
[433.643171] [115/133] (594s left) gem_mmap_gtt (coherency)
[433.704275] Subtest coherency: SKIP (0.000s)
[433.759844] [116/133] (594s left) prime_mmap (test_forked_cpu_write)
[433.812172] Starting subtest: test_forked_cpu_write
[433.814168] Starting dynamic subtest: test_forked_cpu_write-smem
[433.818562] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[433.820827] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[433.954446] [117/133] (594s left) kms_flip (2x-nonexisting-fb)
[434.049163] Starting subtest: 2x-nonexisting-fb
[434.060229] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[434.153226] [118/133] (593s left) kms_flip (flip-vs-panning-interruptible)
[434.260271] Starting subtest: flip-vs-panning-interruptible
[434.262793] Starting dynamic subtest: A-eDP1
[442.929093] Dynamic subtest A-eDP1: SUCCESS (8.669s)
[442.940720] Starting dynamic subtest: B-eDP1
[451.661171] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[451.671507] Starting dynamic subtest: C-eDP1
[460.379843] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[460.389784] Starting dynamic subtest: D-eDP1
[469.110135] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[469.115075] Subtest flip-vs-panning-interruptible: SUCCESS (34.857s)
[470.372837] [119/133] (557s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[470.461330] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[470.463594] Starting dynamic subtest: pipe-A-eDP-1
[470.486894] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[470.498121] Starting dynamic subtest: pipe-B-eDP-1
[470.519966] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[470.528320] Starting dynamic subtest: pipe-C-eDP-1
[470.551762] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[470.561777] Starting dynamic subtest: pipe-D-eDP-1
[470.582965] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[470.587444] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[472.638238] [120/133] (555s left) i915_pm_rpm (debugfs-forcewake-user)
[474.167934] Starting subtest: debugfs-forcewake-user
[485.544994] Subtest debugfs-forcewake-user: SUCCESS (11.380s)
[485.937076] [121/133] (542s left) gem_eio (throttle)
[486.175800] Starting subtest: throttle
[486.518083] Subtest throttle: SUCCESS (0.340s)
[486.684492] [122/133] (541s left) gem_ctx_param (invalid-size-set)
[486.745854] Starting subtest: invalid-size-set
[486.748160] Subtest invalid-size-set: SUCCESS (0.001s)
[486.871982] [123/133] (541s left) perf_pmu (pmu-read)
[486.910439] Starting subtest: pmu-read
[486.912434] Subtest pmu-read: SUCCESS (0.002s)
[487.042442] [124/133] (541s left) gem_lmem_swapping (verify-ccs)
[487.081649] Subtest verify-ccs: SKIP (0.000s)
[487.130098] [125/133] (541s left) gen9_exec_parse (batch-invalid-length)
[487.192484] Subtest batch-invalid-length: SKIP (0.000s)
[487.273568] [126/133] (541s left) gem_softpin (overlap)
[487.341209] Starting subtest: overlap
[488.227680] Subtest overlap: SUCCESS (0.885s)
[488.388075] [127/133] (539s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[488.491247] Starting subtest: 4-tiled-8bpp-rotate-180
[489.705016] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.213s)
[489.859455] [128/133] (538s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[489.965727] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[489.969297] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[490.045971] [129/133] (538s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[490.141461] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[490.143405] Starting dynamic subtest: pipe-A-eDP-1
[495.980554] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.840s)
[495.990545] Starting dynamic subtest: pipe-B-eDP-1
[502.568100] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.584s)
[502.570489] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.427s)
[503.449388] [130/133] (525s left) i915_pm_freq_api (freq-suspend)
[503.531306] Starting subtest: freq-suspend
[503.533567] Starting dynamic subtest: gt0
[519.973112] Dynamic subtest gt0: SUCCESS (2.043s)
[519.985483] Starting dynamic subtest: gt1
[535.959684] Dynamic subtest gt1: SUCCESS (1.228s)
[535.962635] Subtest freq-suspend: SUCCESS (3.275s)
[537.062301] [131/133] (492s left) prime_busy (after)
[537.119040] Starting subtest: after
[537.124055] Starting dynamic subtest: rcs0
[537.158412] Dynamic subtest rcs0: SUCCESS (0.035s)
[537.168610] Starting dynamic subtest: bcs0
[537.219513] Dynamic subtest bcs0: SUCCESS (0.058s)
[537.230654] Starting dynamic subtest: vcs0
[537.259909] Dynamic subtest vcs0: SUCCESS (0.039s)
[537.269677] Starting dynamic subtest: vcs1
[537.301082] Dynamic subtest vcs1: SUCCESS (0.039s)
[537.310860] Starting dynamic subtest: vecs0
[537.342078] Dynamic subtest vecs0: SUCCESS (0.039s)
[537.351770] Starting dynamic subtest: ccs0
[537.382733] Dynamic subtest ccs0: SUCCESS (0.039s)
[537.521407] Subtest after: SUCCESS (0.361s)
[537.580030] [132/133] (492s left) gem_exec_whisper (basic-contexts-forked)
[537.648954] Starting subtest: basic-contexts-forked
[562.397594] Subtest basic-contexts-forked: SUCCESS (24.568s)
[562.610134] [133/133] (467s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[562.663697] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[562.768900] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[562.854266] Closing watchdogs
results: parsing output: 0/ for test: kms_color
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_busy
results: parsing output: 5/ for test: kms_draw_crc
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: gem_exec_flush
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_fence_thrash
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_chamelium_edid
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: i915_pm_rps
results: parsing output: 22/ for test: gem_close
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_mmap_offset
results: parsing output: 27/ for test: kms_pipe_b_c_ivb
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: kms_setmode
results: parsing output: 31/ for test: gem_exec_alignment
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: kms_display_modes
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_mmap_write_crc
results: parsing output: 38/ for test: gem_spin_batch
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_rotation_crc
results: parsing output: 41/ for test: gem_exec_alignment
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: gem_render_copy_redux
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_lmem_swapping
results: parsing output: 52/ for test: core_getclient
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_plane_lowres
results: parsing output: 55/ for test: api_intel_allocator
results: parsing output: 56/ for test: i915_drm_fdinfo
results: parsing output: 57/ for test: gem_exec_parallel
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_getfb
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_pm_rpm
results: parsing output: 67/ for test: gem_ccs
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_cursor_edge_walk
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_capture
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: kms_hdr
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_vrr
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_prop_blob
results: parsing output: 82/ for test: sysfs_preempt_timeout
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: syncobj_eventfd
results: parsing output: 91/ for test: gem_sync
results: parsing output: 92/ for test: core_getversion
results: parsing output: 93/ for test: gem_ctx_exec
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: kms_invalid_mode
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_tiled_wc
results: parsing output: 101/ for test: kms_universal_plane
results: parsing output: 102/ for test: kms_plane_alpha_blend
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: gem_pread
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: kms_getfb
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_atomic
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: prime_mmap
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: i915_pm_freq_api
results: parsing output: 130/ for test: prime_busy
results: parsing output: 131/ for test: gem_exec_whisper
results: parsing output: 132/ for test: syncobj_timeline
Done.