[57.536131] Initializing watchdogs
[57.536174]   /dev/watchdog0
[57.550436] [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]
[57.554660] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.557055] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.560373] [001/133] (960s left) kms_color (ctm-0-25)
[57.690702] Starting subtest: ctm-0-25
[57.692955] Starting dynamic subtest: pipe-A-eDP-1
[61.210058] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.530s)
[61.218337] Starting dynamic subtest: pipe-B-eDP-1
[65.404344] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.202s)
[65.412634] Starting dynamic subtest: pipe-C-eDP-1
[69.442645] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.040s)
[69.451243] Starting dynamic subtest: pipe-D-eDP-1
[73.424550] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.983s)
[73.426873] Subtest ctm-0-25: SUCCESS (15.757s)
[74.286501] [002/133] (943s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[74.389809] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[74.394320] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[74.499813] [003/133] (943s left) gem_exec_balancer (noheartbeat)
[74.766934] Starting subtest: noheartbeat
[74.771646] Subtest noheartbeat: SKIP (0.000s)
[74.897239] [004/133] (943s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[75.027916] Starting subtest: cursorB-vs-flipB-atomic-transitions
[75.032436] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[75.181386] [005/133] (943s left) kms_busy (extended-pageflip-hang-oldfb)
[75.285501] Starting subtest: extended-pageflip-hang-oldfb
[75.287937] Starting dynamic subtest: pipe-A
[75.702389] Dynamic subtest pipe-A: SUCCESS (0.415s)
[75.710463] Starting dynamic subtest: pipe-D
[76.865379] Dynamic subtest pipe-D: SUCCESS (1.162s)
[76.867740] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.581s)
[77.724866] [006/133] (940s left) kms_draw_crc (draw-method-mmap-wc)
[77.823116] Starting subtest: draw-method-mmap-wc
[77.825318] Starting dynamic subtest: xrgb8888-untiled
[78.054496] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[78.064871] Starting dynamic subtest: rgb565-untiled
[78.265336] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[78.273756] Starting dynamic subtest: xrgb2101010-untiled
[78.476122] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[78.484664] Starting dynamic subtest: xbgr16161616f-untiled
[78.676061] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.200s)
[78.683393] Starting dynamic subtest: xrgb8888-xtiled
[78.820959] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[78.830823] Starting dynamic subtest: rgb565-xtiled
[78.953784] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[78.961455] Starting dynamic subtest: xrgb2101010-xtiled
[79.087177] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[79.094607] Starting dynamic subtest: xbgr16161616f-xtiled
[79.221224] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[79.232205] Starting dynamic subtest: xrgb8888-4tiled
[79.387328] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.165s)
[79.396297] Starting dynamic subtest: rgb565-4tiled
[79.542897] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[79.550377] Starting dynamic subtest: xrgb2101010-4tiled
[79.698358] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[79.705134] Starting dynamic subtest: xbgr16161616f-4tiled
[79.865120] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[79.867074] Subtest draw-method-mmap-wc: SUCCESS (2.044s)
[80.002569] [007/133] (938s left) kms_content_protection (uevent)
[80.160566] Starting subtest: uevent
[80.164441] Subtest uevent: SKIP (0.000s)
[80.336764] [008/133] (938s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[80.487260] Starting subtest: cursor-rapid-movement-32x32
[80.530804] Subtest cursor-rapid-movement-32x32: SKIP (0.041s)
[80.839345] [009/133] (937s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[80.894781] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[80.898374] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[81.087827] [010/133] (937s left) gem_exec_fence (syncobj-import)
[81.541592] Starting subtest: syncobj-import
[81.543897] Subtest syncobj-import: SUCCESS (0.005s)
[83.029149] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[83.032108] [011/133] (935s left) gem_exec_flush (basic-wb-pro-default)
[83.113876] Starting subtest: basic-wb-pro-default
[88.578333] Subtest basic-wb-pro-default: SUCCESS (5.467s)
[88.784928] [012/133] (929s left) gem_exec_schedule (preempt-other)
[88.867529] Starting subtest: preempt-other
[88.869549] Starting dynamic subtest: rcs0
[88.990702] Dynamic subtest rcs0: SUCCESS (0.125s)
[89.001769] Starting dynamic subtest: bcs0
[89.101221] Dynamic subtest bcs0: SUCCESS (0.112s)
[89.113078] Starting dynamic subtest: vcs0
[89.214038] Dynamic subtest vcs0: SUCCESS (0.112s)
[89.224065] Starting dynamic subtest: vcs1
[89.324768] Dynamic subtest vcs1: SUCCESS (0.111s)
[89.336062] Starting dynamic subtest: vecs0
[89.438104] Dynamic subtest vecs0: SUCCESS (0.111s)
[89.447136] Starting dynamic subtest: ccs0
[89.548545] Dynamic subtest ccs0: SUCCESS (0.111s)
[89.551285] Subtest preempt-other: SUCCESS (0.684s)
[91.028606] [013/133] (927s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[91.129343] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[98.486204] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.359s)
[98.664689] [014/133] (919s left) gem_fence_thrash (bo-write-verify-threaded-y)
[98.703100] Starting subtest: bo-write-verify-threaded-y
[98.732391] Subtest bo-write-verify-threaded-y: SKIP (0.027s)
[98.801154] [015/133] (919s left) kms_addfb_basic (invalid-set-prop-any)
[98.848130] Starting subtest: invalid-set-prop-any
[98.850318] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[99.011160] [016/133] (919s left) gem_pxp (reject-modify-context-protection-off-3)
[99.144541] Starting subtest: reject-modify-context-protection-off-3
[99.147061] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[99.317584] [017/133] (919s left) gem_exec_schedule (fairslice-all)
[99.395640] Starting subtest: fairslice-all
[101.444703] Subtest fairslice-all: SUCCESS (2.056s)
[102.981438] [018/133] (915s left) kms_chamelium_edid (dp-mode-timings)
[103.377433] Subtest dp-mode-timings: SKIP (0.000s)
[104.239386] [019/133] (914s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[104.339882] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[104.341753] Starting dynamic subtest: pipe-A-eDP-1
[106.542950] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.203s)
[106.551198] Starting dynamic subtest: pipe-B-eDP-1
[108.824215] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.281s)
[108.832026] Starting dynamic subtest: pipe-C-eDP-1
[111.041892] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.216s)
[111.049302] Starting dynamic subtest: pipe-D-eDP-1
[113.062935] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.019s)
[113.065140] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.725s)
[114.310848] [020/133] (904s left) gem_ctx_param (invalid-get-no-zeromap)
[114.378649] Starting subtest: invalid-get-no-zeromap
[114.380669] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[114.503106] [021/133] (904s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[114.593345] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[122.001773] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.411s)
[122.162140] [022/133] (896s left) i915_pm_rps (thresholds-idle)
[122.246618] Starting subtest: thresholds-idle
[122.251321] Subtest thresholds-idle: SKIP (0.001s)
[122.340900] [023/133] (896s left) gem_close (many-handles-one-vma)
[122.406465] Starting subtest: many-handles-one-vma
[122.430828] Subtest many-handles-one-vma: SUCCESS (0.024s)
[122.576741] [024/133] (896s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[122.680256] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[122.684533] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[122.802829] [025/133] (896s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[123.187753] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[124.003825] [026/133] (895s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[124.118888] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[124.123400] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[124.242008] [027/133] (894s left) gem_mmap_offset (clear-via-pagefault)
[124.304704] Starting subtest: clear-via-pagefault
[124.306918] Starting dynamic subtest: smem0
[156.709061] Dynamic subtest smem0: SUCCESS (32.397s)
[156.711223] Subtest clear-via-pagefault: SUCCESS (32.399s)
[156.845135] [028/133] (862s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[156.900750] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[156.970345] [029/133] (862s left) kms_psr (pr-sprite-render)
[157.067036] Starting subtest: pr-sprite-render
[157.071472] Subtest pr-sprite-render: SKIP (0.000s)
[157.153364] [030/133] (862s left) gem_exec_reloc (basic-cpu-read-noreloc)
[157.226836] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[157.325215] [031/133] (861s left) kms_setmode (basic-clone-single-crtc)
[157.384257] Starting subtest: basic-clone-single-crtc
[157.390580] Subtest basic-clone-single-crtc: SKIP (0.000s)
[157.508319] [032/133] (861s left) gem_exec_alignment (pi-isolated)
[157.571517] Starting subtest: pi-isolated
[209.466054] Subtest pi-isolated: SUCCESS (51.886s)
[209.646838] [033/133] (809s left) gem_ctx_persistence (heartbeat-hang)
[209.746039] Starting subtest: heartbeat-hang
[209.751517] Subtest heartbeat-hang: SKIP (0.000s)
[209.896943] [034/133] (809s left) kms_display_modes (extended-mode-basic)
[210.002931] Starting subtest: extended-mode-basic
[210.007384] Subtest extended-mode-basic: SKIP (0.000s)
[210.050511] [035/133] (809s left) kms_plane (plane-position-hole)
[210.147928] Starting subtest: plane-position-hole
[210.671689] Starting dynamic subtest: pipe-A-plane-1
[211.981677] Dynamic subtest pipe-A-plane-1: SUCCESS (1.308s)
[211.990407] Starting dynamic subtest: pipe-A-plane-2
[213.210541] Dynamic subtest pipe-A-plane-2: SUCCESS (1.229s)
[213.221080] Starting dynamic subtest: pipe-A-plane-3
[214.453072] Dynamic subtest pipe-A-plane-3: SUCCESS (1.243s)
[214.463946] Starting dynamic subtest: pipe-A-plane-4
[215.829573] Dynamic subtest pipe-A-plane-4: SUCCESS (1.374s)
[215.838756] Starting dynamic subtest: pipe-A-plane-5
[215.854360] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[217.037064] Starting dynamic subtest: pipe-B-plane-1
[218.332338] Dynamic subtest pipe-B-plane-1: SUCCESS (1.304s)
[218.341694] Starting dynamic subtest: pipe-B-plane-2
[219.583779] Dynamic subtest pipe-B-plane-2: SUCCESS (1.249s)
[219.592484] Starting dynamic subtest: pipe-B-plane-3
[220.819032] Dynamic subtest pipe-B-plane-3: SUCCESS (1.235s)
[220.827257] Starting dynamic subtest: pipe-B-plane-4
[222.076153] Dynamic subtest pipe-B-plane-4: SUCCESS (1.254s)
[222.084578] Starting dynamic subtest: pipe-B-plane-5
[222.102271] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[222.104538] Subtest plane-position-hole: SUCCESS (11.953s)
[222.965731] [036/133] (796s left) kms_pm_backlight (bad-brightness)
[223.068086] Starting subtest: bad-brightness
[223.144397] Starting dynamic subtest: eDP-1
[223.454623] Dynamic subtest eDP-1: SUCCESS (0.306s)
[223.457061] Subtest bad-brightness: SUCCESS (0.384s)
[224.286407] [037/133] (795s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[224.361922] Starting subtest: multi-wait-available-unsubmitted-signaled
[224.364324] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[224.489209] [038/133] (795s left) kms_mmap_write_crc (main)
[224.589295] Starting subtest: main
[224.591569] Starting dynamic subtest: pipe-A-eDP-1
[228.284954] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.694s)
[228.287191] Subtest main: SUCCESS (3.696s)
[229.115930] [039/133] (790s left) gem_spin_batch (resubmit-new-all)
[229.193908] Starting subtest: resubmit-new-all
[229.196389] Starting dynamic subtest: rcs0
[229.207981] Dynamic subtest rcs0: SUCCESS (0.014s)
[229.217870] Starting dynamic subtest: bcs0
[229.220424] Dynamic subtest bcs0: SUCCESS (0.010s)
[229.231259] Starting dynamic subtest: vcs0
[229.233280] Dynamic subtest vcs0: SUCCESS (0.009s)
[229.241027] Starting dynamic subtest: vcs1
[229.242817] Dynamic subtest vcs1: SUCCESS (0.009s)
[229.251204] Starting dynamic subtest: vecs0
[229.253294] Dynamic subtest vecs0: SUCCESS (0.008s)
[229.261080] Starting dynamic subtest: ccs0
[229.262897] Dynamic subtest ccs0: SUCCESS (0.008s)
[229.264810] Subtest resubmit-new-all: SUCCESS (0.062s)
[230.986882] [040/133] (788s left) kms_flip (flip-vs-rmfb-interruptible)
[231.096896] Starting subtest: flip-vs-rmfb-interruptible
[231.099234] Starting dynamic subtest: A-eDP1
[239.791391] Dynamic subtest A-eDP1: SUCCESS (8.692s)
[239.800486] Starting dynamic subtest: B-eDP1
[248.426268] Dynamic subtest B-eDP1: SUCCESS (8.633s)
[248.435267] Starting dynamic subtest: C-eDP1
[257.050975] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[257.060580] Starting dynamic subtest: D-eDP1
[265.677133] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[265.681715] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.582s)
[266.873719] [041/133] (752s left) kms_rotation_crc (sprite-rotation-180)
[266.981483] Starting subtest: sprite-rotation-180
[273.767300] Subtest sprite-rotation-180: SUCCESS (6.789s)
[275.048655] [042/133] (744s left) gem_exec_alignment (single)
[275.114310] Starting subtest: single
[275.116498] Subtest single: SUCCESS (0.002s)
[275.260360] [043/133] (744s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[275.372761] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[276.352506] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.981s)
[276.533133] [044/133] (743s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[276.632276] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[284.108794] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.478s)
[284.256084] [045/133] (735s left) syncobj_wait (invalid-signal-zero-handles)
[284.312877] Starting subtest: invalid-signal-zero-handles
[284.315210] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[284.429728] [046/133] (735s left) kms_async_flips (alternate-sync-async-flip)
[284.532130] Starting subtest: alternate-sync-async-flip
[284.901844] Starting dynamic subtest: pipe-A-eDP-1
[287.718443] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.817s)
[288.085560] Starting dynamic subtest: pipe-B-eDP-1
[290.852788] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.775s)
[291.241290] Starting dynamic subtest: pipe-C-eDP-1
[293.990610] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.755s)
[294.359857] Starting dynamic subtest: pipe-D-eDP-1
[297.122587] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[297.124623] Subtest alternate-sync-async-flip: SUCCESS (12.590s)
[298.310714] [047/133] (721s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[298.412833] Starting subtest: fbcpsr-1p-rte
[305.466319] Subtest fbcpsr-1p-rte: SUCCESS (7.057s)
[305.636353] [048/133] (714s left) perf (gen12-group-exclusive-stream-ctx-handle)
[305.778334] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[305.801430] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s)
[305.842481] [049/133] (714s left) gem_render_copy_redux (flink-interruptible)
[306.875862] Starting subtest: flink-interruptible
[307.622444] Subtest flink-interruptible: SUCCESS (0.748s)
[307.764068] [050/133] (712s left) gem_userptr_blits (probe)
[307.845802] Starting subtest: probe
[307.919399] Subtest probe: SUCCESS (0.074s)
[308.096040] [051/133] (712s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[308.213355] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[308.216788] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[308.313187] [052/133] (711s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[308.359886] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[308.414293] [053/133] (711s left) core_getclient (basic)
[308.474206] Starting subtest: basic
[308.475744] Subtest basic: SUCCESS (0.000s)
[308.600533] [054/133] (711s left) kms_cursor_crc (cursor-onscreen-128x128)
[308.804398] Starting subtest: cursor-onscreen-128x128
[308.808474] Starting dynamic subtest: pipe-A-eDP-1
[310.927453] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.118s)
[310.955849] Starting dynamic subtest: pipe-D-eDP-1
[313.732449] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[313.734795] Subtest cursor-onscreen-128x128: SUCCESS (4.926s)
[314.614980] [055/133] (705s left) kms_plane_lowres (tiling-y)
[314.722913] Starting subtest: tiling-y
[314.727200] Subtest tiling-y: SKIP (0.000s)
[314.818708] [056/133] (705s left) api_intel_allocator (gem-pool)
[314.877472] Starting subtest: gem-pool
[314.883913] Subtest gem-pool: SUCCESS (0.008s)
[315.044886] [057/133] (705s left) i915_drm_fdinfo (isolation)
[315.085985] Starting subtest: isolation
[315.088284] Starting dynamic subtest: rcs0
[315.129204] Dynamic subtest rcs0: SKIP (0.041s)
[315.139860] Starting dynamic subtest: bcs0
[315.144089] Dynamic subtest bcs0: SKIP (0.001s)
[315.152072] Starting dynamic subtest: vcs0
[315.156015] Dynamic subtest vcs0: SKIP (0.000s)
[315.164038] Starting dynamic subtest: vcs1
[315.168148] Dynamic subtest vcs1: SKIP (0.000s)
[315.175930] Starting dynamic subtest: vecs0
[315.180130] Dynamic subtest vecs0: SKIP (0.000s)
[315.187926] Starting dynamic subtest: ccs0
[315.192116] Dynamic subtest ccs0: SKIP (0.000s)
[315.196123] Subtest isolation: SKIP (0.049s)
[315.232171] [058/133] (705s left) gem_exec_parallel (basic)
[315.293898] Starting subtest: basic
[315.296179] Starting dynamic subtest: rcs0
[316.727537] Dynamic subtest rcs0: SUCCESS (1.433s)
[316.738894] Starting dynamic subtest: bcs0
[318.197641] Dynamic subtest bcs0: SUCCESS (1.468s)
[318.209040] Starting dynamic subtest: vcs0
[319.894080] Dynamic subtest vcs0: SUCCESS (1.692s)
[319.905189] Starting dynamic subtest: vcs1
[321.877087] Dynamic subtest vcs1: SUCCESS (1.982s)
[321.887987] Starting dynamic subtest: vecs0
[323.861385] Dynamic subtest vecs0: SUCCESS (1.982s)
[323.873029] Starting dynamic subtest: ccs0
[325.333601] Dynamic subtest ccs0: SUCCESS (1.471s)
[325.336073] Subtest basic: SUCCESS (10.040s)
[325.546688] [059/133] (694s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[325.647073] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[325.651319] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[325.753885] [060/133] (694s left) kms_getfb (getfb-handle-valid)
[325.855064] Starting subtest: getfb-handle-valid
[325.857189] Subtest getfb-handle-valid: SUCCESS (0.000s)
[325.990826] [061/133] (694s left) perf (invalid-remove-userspace-config)
[326.102985] Starting subtest: invalid-remove-userspace-config
[326.116256] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[326.174521] [062/133] (694s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[326.274777] Starting subtest: pr-primary-plane-update-sf-dmg-area
[326.279205] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[326.355457] [063/133] (694s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[326.469816] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[326.473249] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[326.572215] [064/133] (694s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[326.660041] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[326.673613] Starting dynamic subtest: pipe-A-eDP-1
[326.691562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[326.699523] Starting dynamic subtest: pipe-B-eDP-1
[326.716406] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[326.724102] Starting dynamic subtest: pipe-C-eDP-1
[326.741110] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[326.748489] Starting dynamic subtest: pipe-D-eDP-1
[326.766251] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[326.769743] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[328.987166] [065/133] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[329.077661] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[335.971849] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.895s)
[336.153778] [066/133] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[336.263950] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[336.268020] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[336.380366] [067/133] (684s left) kms_pm_rpm (cursor-dpms)
[338.008643] Starting subtest: cursor-dpms
[338.013393] Subtest cursor-dpms: SKIP (0.000s)
[338.633862] [068/133] (682s left) gem_ccs (block-multicopy-inplace)
[338.691864] Starting subtest: block-multicopy-inplace
[338.696117] Subtest block-multicopy-inplace: SKIP (0.000s)
[338.813451] [069/133] (682s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[338.913748] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[338.918047] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[339.034114] [070/133] (681s left) kms_cursor_edge_walk (64x64-top-bottom)
[339.135115] Starting subtest: 64x64-top-bottom
[339.137378] Starting dynamic subtest: pipe-A-eDP-1
[342.576245] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[342.585985] Starting dynamic subtest: pipe-D-eDP-1
[345.688394] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[345.690682] Subtest 64x64-top-bottom: SUCCESS (6.555s)
[346.520411] [071/133] (674s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[346.580360] Starting subtest: invalid-single-wait-all-unsubmitted
[346.582553] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[346.674246] [072/133] (674s left) gem_exec_capture (pi)
[346.745061] Starting subtest: pi
[346.747284] Starting dynamic subtest: rcs0
[351.121855] Dynamic subtest rcs0: SUCCESS (4.376s)
[351.132350] Starting dynamic subtest: bcs0
[355.264758] Dynamic subtest bcs0: SUCCESS (4.141s)
[355.276041] Starting dynamic subtest: vcs0
[359.396085] Dynamic subtest vcs0: SUCCESS (4.129s)
[359.407614] Starting dynamic subtest: vcs1
[363.551393] Dynamic subtest vcs1: SUCCESS (4.153s)
[363.562708] Starting dynamic subtest: vecs0
[367.695331] Dynamic subtest vecs0: SUCCESS (4.141s)
[367.707294] Starting dynamic subtest: ccs0
[371.863188] Dynamic subtest ccs0: SUCCESS (4.166s)
[371.865711] Subtest pi: SUCCESS (25.118s)
[371.972481] [073/133] (649s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[372.124049] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[372.128148] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[372.220343] [074/133] (648s left) kms_hdr (static-swap)
[372.312344] Starting subtest: static-swap
[372.318568] Subtest static-swap: SKIP (0.000s)
[372.396458] [075/133] (648s left) syncobj_wait (wait-for-submit-delayed-submit)
[372.457869] Starting subtest: wait-for-submit-delayed-submit
[372.559083] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[372.646089] [076/133] (648s left) kms_vrr (flip-dpms)
[372.733075] Starting subtest: flip-dpms
[372.739629] Subtest flip-dpms: SKIP (0.000s)
[372.813750] [077/133] (648s left) kms_big_fb (linear-addfb)
[372.925663] Starting subtest: linear-addfb
[372.927727] Subtest linear-addfb: SUCCESS (0.000s)
[373.063423] [078/133] (648s left) kms_addfb_basic (addfb25-bad-modifier)
[373.151710] Starting subtest: addfb25-bad-modifier
[373.153562] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[373.275266] [079/133] (648s left) kms_psr (psr-sprite-plane-onoff)
[373.373696] Starting subtest: psr-sprite-plane-onoff
[373.375712] Starting dynamic subtest: eDP-1
[375.148063] Dynamic subtest eDP-1: SUCCESS (1.773s)
[375.150394] Subtest psr-sprite-plane-onoff: SUCCESS (1.774s)
[375.974878] [080/133] (645s left) kms_psr (fbc-psr-sprite-plane-move)
[376.073314] Starting subtest: fbc-psr-sprite-plane-move
[376.075576] Starting dynamic subtest: eDP-1
[376.079629] Dynamic subtest eDP-1: SKIP (0.000s)
[376.083755] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[376.162106] [081/133] (645s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[376.287138] Starting subtest: fbcpsr-rgb101010-draw-blt
[383.041630] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.756s)
[383.208406] [082/133] (638s left) kms_prop_blob (invalid-get-prop)
[383.263689] Starting subtest: invalid-get-prop
[383.265623] Subtest invalid-get-prop: SUCCESS (0.000s)
[383.401055] [083/133] (638s left) sysfs_preempt_timeout (idempotent)
[383.473674] Starting subtest: idempotent
[383.476291] Starting dynamic subtest: vecs0
[383.478683] Dynamic subtest vecs0: SUCCESS (0.000s)
[383.488933] Starting dynamic subtest: ccs0
[383.490843] Dynamic subtest ccs0: SUCCESS (0.000s)
[383.498465] Starting dynamic subtest: vcs0
[383.500318] Dynamic subtest vcs0: SUCCESS (0.000s)
[383.508059] Starting dynamic subtest: bcs0
[383.509903] Dynamic subtest bcs0: SUCCESS (0.000s)
[383.517520] Starting dynamic subtest: rcs0
[383.519443] Dynamic subtest rcs0: SUCCESS (0.000s)
[383.527066] Starting dynamic subtest: vcs1
[383.528916] Dynamic subtest vcs1: SUCCESS (0.000s)
[383.530780] Subtest idempotent: SUCCESS (0.007s)
[383.605439] [084/133] (637s left) kms_psr (fbc-pr-primary-page-flip)
[383.702146] Starting subtest: fbc-pr-primary-page-flip
[383.706578] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[383.799985] [085/133] (637s left) gem_exec_reloc (basic-gtt-active)
[383.859445] Subtest basic-gtt-active: SKIP (0.000s)
[383.941909] [086/133] (637s left) kms_chamelium_color (ctm-0-75)
[384.045548] Subtest ctm-0-75: SKIP (0.000s)
[384.093847] [087/133] (637s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[384.181244] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[384.183253] Starting dynamic subtest: pipe-A-default-mode
[386.956223] Dynamic subtest pipe-A-default-mode: SUCCESS (2.775s)
[386.958673] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.777s)
[387.813445] [088/133] (633s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[387.916251] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[392.192719] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.279s)
[393.396255] [089/133] (628s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[393.503954] Starting subtest: psr-indfb-scaledprimary
[399.254805] Subtest psr-indfb-scaledprimary: SUCCESS (5.754s)
[399.402496] [090/133] (622s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[399.513612] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[399.518090] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[399.640545] [091/133] (622s left) syncobj_eventfd (timeline-wait)
[399.699173] Starting subtest: timeline-wait
[399.707856] Subtest timeline-wait: SUCCESS (0.010s)
[399.828865] [092/133] (622s left) gem_sync (basic-store-each)
[399.891247] Starting subtest: basic-store-each
[402.363262] Subtest basic-store-each: SUCCESS (2.482s)
[402.575589] [093/133] (619s left) core_getversion (all-cards)
[402.619536] Starting subtest: all-cards
[402.627192] Subtest all-cards: SUCCESS (0.012s)
[402.668714] [094/133] (619s left) gem_ctx_exec (basic-invalid-context)
[402.732788] Starting subtest: basic-invalid-context
[402.739759] Subtest basic-invalid-context: SUCCESS (0.009s)
[402.867408] [095/133] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[402.977490] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[407.543851] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.570s)
[408.719606] [096/133] (613s left) kms_prop_blob (blob-multiple)
[408.775645] Starting subtest: blob-multiple
[408.778072] Subtest blob-multiple: SUCCESS (0.002s)
[408.905498] [097/133] (613s left) kms_invalid_mode (zero-clock)
[408.998557] Starting subtest: zero-clock
[409.000866] Starting dynamic subtest: pipe-A-eDP-1
[409.280102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[409.289760] Starting dynamic subtest: pipe-B-eDP-1
[409.291721] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[409.299246] Starting dynamic subtest: pipe-C-eDP-1
[409.301710] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[409.309544] Starting dynamic subtest: pipe-D-eDP-1
[409.311858] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[409.314171] Subtest zero-clock: SUCCESS (0.289s)
[410.137528] [098/133] (611s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[410.225539] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[410.227783] Starting dynamic subtest: pipe-A-default-mode
[412.990973] Dynamic subtest pipe-A-default-mode: SUCCESS (2.764s)
[412.993608] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.765s)
[413.834688] [099/133] (608s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[413.930474] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[413.932762] Starting dynamic subtest: pipe-A-eDP-1
[413.958465] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[413.969066] Starting dynamic subtest: pipe-B-eDP-1
[413.994624] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[414.003217] Starting dynamic subtest: pipe-C-eDP-1
[414.027375] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[414.036077] Starting dynamic subtest: pipe-D-eDP-1
[414.060631] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[414.064797] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.013s)
[416.120339] [100/133] (606s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[416.226319] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[416.230591] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[416.371065] [101/133] (605s left) gem_tiled_wc
[416.501724] [102/133] (605s left) kms_universal_plane (universal-plane-sanity)
[416.587407] Starting subtest: universal-plane-sanity
[416.589740] Starting dynamic subtest: pipe-A-eDP-1
[417.186902] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[417.196414] Starting dynamic subtest: pipe-B-eDP-1
[418.435603] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.249s)
[418.444894] Starting dynamic subtest: pipe-C-eDP-1
[419.644055] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s)
[419.654628] Starting dynamic subtest: pipe-D-eDP-1
[420.870045] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[420.872537] Subtest universal-plane-sanity: SUCCESS (4.283s)
[421.737170] [103/133] (600s left) kms_plane_alpha_blend (alpha-opaque-fb)
[421.833598] Starting subtest: alpha-opaque-fb
[422.113993] Starting dynamic subtest: pipe-A-eDP-1
[422.769698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.655s)
[422.780112] Starting dynamic subtest: pipe-D-eDP-1
[424.179879] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.407s)
[424.182360] Subtest alpha-opaque-fb: SUCCESS (2.347s)
[424.999582] [104/133] (597s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[425.107151] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[425.111369] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[425.246582] [105/133] (597s left) kms_psr (psr2-primary-mmap-gtt)
[425.339927] Starting subtest: psr2-primary-mmap-gtt
[425.342260] Starting dynamic subtest: eDP-1
[426.777923] Dynamic subtest eDP-1: SKIP (1.436s)
[426.782845] Subtest psr2-primary-mmap-gtt: SKIP (1.438s)
[426.962555] [106/133] (595s left) gem_exec_schedule (semaphore-codependency)
[427.049683] Starting subtest: semaphore-codependency
[427.054483] Subtest semaphore-codependency: SUCCESS (0.011s)
[427.412516] [107/133] (595s left) gem_pread (bench)
[427.473579] Subtest bench: SKIP (0.000s)
[427.535455] [108/133] (594s left) drm_read (fault-buffer)
[427.718051] Starting subtest: fault-buffer
[427.720403] Subtest fault-buffer: SUCCESS (0.000s)
[427.867994] [109/133] (594s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[427.973030] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[427.977194] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[428.092122] [110/133] (594s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[428.207034] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[428.211300] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[428.321477] [111/133] (594s left) gem_softpin (evict-snoop)
[428.386590] Starting subtest: evict-snoop
[428.390370] Subtest evict-snoop: SKIP (0.000s)
[428.509297] [112/133] (594s left) kms_getfb (getfb-handle-not-fb)
[428.601412] Starting subtest: getfb-handle-not-fb
[428.603364] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[428.718855] [113/133] (593s left) syncobj_timeline (wait-all-delayed-signal)
[428.780941] Starting subtest: wait-all-delayed-signal
[428.883805] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[428.973911] [114/133] (593s left) kms_atomic (plane-invalid-params-fence)
[429.061349] Starting subtest: plane-invalid-params-fence
[429.063690] Starting dynamic subtest: pipe-A-eDP-1
[429.422175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s)
[429.424057] Subtest plane-invalid-params-fence: SUCCESS (0.361s)
[430.248942] [115/133] (592s left) gem_mmap_gtt (coherency)
[430.307518] Subtest coherency: SKIP (0.000s)
[430.374873] [116/133] (592s left) prime_mmap (test_forked_cpu_write)
[430.441721] Starting subtest: test_forked_cpu_write
[430.443730] Starting dynamic subtest: test_forked_cpu_write-smem
[430.449116] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[430.451482] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[430.585668] [117/133] (592s left) kms_flip (2x-nonexisting-fb)
[430.679222] Starting subtest: 2x-nonexisting-fb
[430.691188] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[430.824935] [118/133] (592s left) kms_flip (flip-vs-panning-interruptible)
[430.929303] Starting subtest: flip-vs-panning-interruptible
[430.931395] Starting dynamic subtest: A-eDP1
[439.639253] Dynamic subtest A-eDP1: SUCCESS (8.709s)
[439.648104] Starting dynamic subtest: B-eDP1
[448.371053] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[448.382112] Starting dynamic subtest: C-eDP1
[457.085126] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[457.093477] Starting dynamic subtest: D-eDP1
[465.815534] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[465.819627] Subtest flip-vs-panning-interruptible: SUCCESS (34.890s)
[466.988168] [119/133] (555s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[467.091409] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[467.093816] Starting dynamic subtest: pipe-A-eDP-1
[467.117156] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[467.127926] Starting dynamic subtest: pipe-B-eDP-1
[467.149281] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[467.157781] Starting dynamic subtest: pipe-C-eDP-1
[467.179444] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[467.189221] Starting dynamic subtest: pipe-D-eDP-1
[467.210751] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.215046] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[469.349972] [120/133] (553s left) i915_pm_rpm (debugfs-forcewake-user)
[471.096634] Starting subtest: debugfs-forcewake-user
[482.505292] Subtest debugfs-forcewake-user: SUCCESS (11.412s)
[482.920592] [121/133] (540s left) gem_eio (throttle)
[483.165573] Starting subtest: throttle
[483.522371] Subtest throttle: SUCCESS (0.357s)
[483.689687] [122/133] (539s left) gem_ctx_param (invalid-size-set)
[483.752282] Starting subtest: invalid-size-set
[483.754483] Subtest invalid-size-set: SUCCESS (0.001s)
[483.876529] [123/133] (539s left) perf_pmu (pmu-read)
[483.917277] Starting subtest: pmu-read
[483.919151] Subtest pmu-read: SUCCESS (0.002s)
[484.048655] [124/133] (539s left) gem_lmem_swapping (verify-ccs)
[484.087615] Subtest verify-ccs: SKIP (0.000s)
[484.140259] [125/133] (539s left) gen9_exec_parse (batch-invalid-length)
[484.208691] Subtest batch-invalid-length: SKIP (0.000s)
[484.288879] [126/133] (538s left) gem_softpin (overlap)
[484.352271] Starting subtest: overlap
[485.293689] Subtest overlap: SUCCESS (0.939s)
[485.453716] [127/133] (537s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[485.562998] Starting subtest: 4-tiled-8bpp-rotate-180
[486.787770] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.225s)
[486.934445] [128/133] (536s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[487.041449] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[487.044864] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[487.127653] [129/133] (536s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[487.240940] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[487.242988] Starting dynamic subtest: pipe-A-eDP-1
[493.176381] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.936s)
[493.186234] Starting dynamic subtest: pipe-B-eDP-1
[499.866316] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.689s)
[499.868666] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.628s)
[500.732838] [130/133] (522s left) i915_pm_freq_api (freq-suspend)
[500.802385] Starting subtest: freq-suspend
[500.804777] Starting dynamic subtest: gt0
[517.908329] Dynamic subtest gt0: SUCCESS (1.746s)
[517.917958] Starting dynamic subtest: gt1
[534.886406] Dynamic subtest gt1: SUCCESS (1.620s)
[534.888536] Subtest freq-suspend: SUCCESS (3.370s)
[542.009658] [131/133] (488s left) prime_busy (after)
[542.084018] Starting subtest: after
[542.089987] Starting dynamic subtest: rcs0
[542.135621] Dynamic subtest rcs0: SUCCESS (0.048s)
[542.150979] Starting dynamic subtest: bcs0
[542.199258] Dynamic subtest bcs0: SUCCESS (0.063s)
[542.214145] Starting dynamic subtest: vcs0
[542.241229] Dynamic subtest vcs0: SUCCESS (0.041s)
[542.256198] Starting dynamic subtest: vcs1
[542.282511] Dynamic subtest vcs1: SUCCESS (0.041s)
[542.293633] Starting dynamic subtest: vecs0
[542.323658] Dynamic subtest vecs0: SUCCESS (0.041s)
[542.333385] Starting dynamic subtest: ccs0
[542.365661] Dynamic subtest ccs0: SUCCESS (0.041s)
[542.475053] Subtest after: SUCCESS (0.390s)
[542.568525] [132/133] (487s left) gem_exec_whisper (basic-contexts-forked)
[542.653304] Starting subtest: basic-contexts-forked
[566.190009] Subtest basic-contexts-forked: SUCCESS (23.667s)
[566.389704] [133/133] (464s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[566.446905] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[566.551808] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[566.660781] 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.