[60.955070] Initializing watchdogs
[60.955138]   /dev/watchdog0
[60.969056] [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]
[60.973527] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.975839] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.979208] [001/133] (960s left) syncobj_basic (bad-flags-handle-to-fd)
[61.054117] Starting subtest: bad-flags-handle-to-fd
[61.056058] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[61.148134] [002/133] (960s left) gem_exec_parallel (basic)
[61.208268] Starting subtest: basic
[61.210575] Starting dynamic subtest: rcs0
[62.727880] Dynamic subtest rcs0: SUCCESS (1.519s)
[62.738851] Starting dynamic subtest: bcs0
[64.212806] Dynamic subtest bcs0: SUCCESS (1.483s)
[64.222386] Starting dynamic subtest: vcs0
[65.901797] Dynamic subtest vcs0: SUCCESS (1.685s)
[65.908905] Starting dynamic subtest: vcs1
[67.891488] Dynamic subtest vcs1: SUCCESS (1.984s)
[67.899017] Starting dynamic subtest: vecs0
[69.909503] Dynamic subtest vecs0: SUCCESS (2.022s)
[69.918957] Starting dynamic subtest: ccs0
[71.405947] Dynamic subtest ccs0: SUCCESS (1.496s)
[71.408623] Subtest basic: SUCCESS (10.195s)
[71.588821] [003/133] (949s left) gem_ctx_persistence (legacy-engines-queued)
[71.651555] Starting subtest: legacy-engines-queued
[71.653637] Starting dynamic subtest: render
[71.732222] Dynamic subtest render: SUCCESS (0.080s)
[71.744085] Starting dynamic subtest: bsd1
[72.885332] Dynamic subtest bsd1: SUCCESS (1.149s)
[72.895606] Starting dynamic subtest: bsd2
[74.869586] Dynamic subtest bsd2: SUCCESS (1.981s)
[74.879417] Starting dynamic subtest: blt
[74.923631] Dynamic subtest blt: SUCCESS (0.055s)
[74.933619] Starting dynamic subtest: vebox
[76.851348] Dynamic subtest vebox: SUCCESS (1.924s)
[76.853755] Subtest legacy-engines-queued: SUCCESS (5.198s)
[76.985289] [004/133] (944s left) kms_content_protection (dp-mst-lic-type-0)
[77.142797] Starting subtest: dp-mst-lic-type-0
[77.147239] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[77.264796] [005/133] (944s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[77.351817] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[77.354201] Starting dynamic subtest: pipe-A-eDP-1
[77.363385] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[77.371692] Starting dynamic subtest: pipe-B-eDP-1
[77.380766] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[77.389266] Starting dynamic subtest: pipe-C-eDP-1
[77.397619] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[77.404440] Starting dynamic subtest: pipe-D-eDP-1
[77.412875] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[77.416986] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[79.590082] [006/133] (942s left) kms_universal_plane (universal-plane-pageflip-windowed)
[79.687682] Starting subtest: universal-plane-pageflip-windowed
[79.689915] Starting dynamic subtest: pipe-A-eDP-1
[80.269056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.582s)
[80.277976] Starting dynamic subtest: pipe-B-eDP-1
[81.522451] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.251s)
[81.531609] Starting dynamic subtest: pipe-C-eDP-1
[82.722546] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[82.731314] Starting dynamic subtest: pipe-D-eDP-1
[83.951389] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[83.953798] Subtest universal-plane-pageflip-windowed: SUCCESS (4.265s)
[84.798914] [007/133] (936s left) gem_mmap_gtt (medium-copy-xy)
[84.866952] Subtest medium-copy-XY: SKIP (0.000s)
[84.921218] [008/133] (936s left) kms_atomic (atomic-plane-damage)
[85.014726] Starting subtest: atomic-plane-damage
[85.089822] Starting dynamic subtest: pipe-A-eDP-1
[85.635901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[85.638257] Subtest atomic-plane-damage: SUCCESS (0.622s)
[86.434309] [009/133] (935s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[86.535942] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[86.540125] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[86.619243] [010/133] (935s left) gem_exec_reloc (basic-gtt-read-noreloc)
[86.681261] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[86.735767] [011/133] (935s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[86.836278] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[86.838691] Starting dynamic subtest: pipe-A-eDP-1
[86.898563] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[86.907640] Starting dynamic subtest: pipe-B-eDP-1
[86.966898] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[86.980740] Starting dynamic subtest: pipe-C-eDP-1
[87.040499] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[87.049815] Starting dynamic subtest: pipe-D-eDP-1
[87.107288] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[87.111443] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[89.086693] [012/133] (932s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[89.254570] Starting subtest: cursor-rapid-movement-32x10
[89.302279] Subtest cursor-rapid-movement-32x10: SKIP (0.044s)
[89.547246] [013/133] (932s left) gem_mmap (bad-size)
[89.609406] Subtest bad-size: SKIP (0.000s)
[89.668636] [014/133] (932s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[89.746143] Starting subtest: plane-ctm3x4-lut1d
[89.891645] Starting dynamic subtest: pipe-A-plane-0
[90.057555] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[90.065568] Starting dynamic subtest: pipe-A-plane-1
[90.213103] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[90.220597] Starting dynamic subtest: pipe-A-plane-2
[90.368763] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[91.602600] Starting dynamic subtest: pipe-B-plane-0
[91.764344] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[91.773535] Starting dynamic subtest: pipe-B-plane-1
[91.931396] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[91.939262] Starting dynamic subtest: pipe-B-plane-2
[92.086362] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[93.318887] Starting dynamic subtest: pipe-C-plane-0
[93.456341] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[93.464086] Starting dynamic subtest: pipe-C-plane-1
[93.601045] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[93.609222] Starting dynamic subtest: pipe-C-plane-2
[93.757048] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[94.929182] Starting dynamic subtest: pipe-D-plane-0
[95.067129] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[95.074628] Starting dynamic subtest: pipe-D-plane-1
[95.223057] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[95.232243] Starting dynamic subtest: pipe-D-plane-2
[95.379042] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[95.667471] Subtest plane-ctm3x4-lut1d: SUCCESS (5.922s)
[96.513672] [015/133] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[96.616691] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[96.621324] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[96.734192] [016/133] (925s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[96.858059] Starting subtest: basic-flip-after-cursor-varying-size
[97.784446] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.925s)
[98.664678] [017/133] (923s left) gem_exec_flush (basic-wb-ro-default)
[98.747337] Starting subtest: basic-wb-ro-default
[104.235865] Subtest basic-wb-ro-default: SUCCESS (5.467s)
[104.409154] [018/133] (917s left) gem_render_copy_redux (flink)
[104.475539] Starting subtest: flink
[105.575681] Subtest flink: SUCCESS (1.101s)
[105.691150] [019/133] (916s left) gem_exec_reloc (basic-write-read-noreloc)
[105.759203] Subtest basic-write-read-noreloc: SKIP (0.000s)
[105.817534] [020/133] (916s left) gem_ctx_param (invalid-set-no-zeromap)
[105.867945] Starting subtest: invalid-set-no-zeromap
[105.869872] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[105.938098] [021/133] (916s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[106.035104] Starting subtest: fbc-dirtyfb-ioctl
[106.037097] Starting dynamic subtest: A-eDP-1
[108.612068] Dynamic subtest A-eDP-1: SUCCESS (2.574s)
[108.614236] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.576s)
[109.403411] [022/133] (912s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[109.452970] Starting subtest: multi-wait-available-submitted-signaled
[109.455381] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[109.546778] [023/133] (912s left) kms_setmode (invalid-clone-single-crtc-stealing)
[109.593266] Starting subtest: invalid-clone-single-crtc-stealing
[109.599500] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[109.680083] [024/133] (912s left) gem_userptr_blits (dmabuf-sync)
[109.740088] Starting subtest: dmabuf-sync
[109.744554] Subtest dmabuf-sync: SKIP (0.003s)
[109.876789] [025/133] (912s left) sriov_basic (bind-unbind-vf)
[109.926825] Starting subtest: bind-unbind-vf
[109.929203] Starting dynamic subtest: vf-1
[110.000577] Dynamic subtest vf-1: FAIL (0.016s)
[110.008940] Starting dynamic subtest: vf-2
[110.082385] Dynamic subtest vf-2: FAIL (0.004s)
[110.091072] Starting dynamic subtest: vf-3
[110.164649] Dynamic subtest vf-3: FAIL (0.004s)
[110.173109] Starting dynamic subtest: vf-4
[110.246399] Dynamic subtest vf-4: FAIL (0.004s)
[110.255844] Starting dynamic subtest: vf-5
[110.328893] Dynamic subtest vf-5: FAIL (0.004s)
[110.337161] Starting dynamic subtest: vf-6
[110.397487] Dynamic subtest vf-6: FAIL (0.003s)
[110.406137] Starting dynamic subtest: vf-7
[110.468343] Dynamic subtest vf-7: FAIL (0.004s)
[110.475243] Starting dynamic subtest: vf-random
[110.534060] Dynamic subtest vf-random: FAIL (0.003s)
[110.542091] Starting dynamic subtest: vf-last
[110.601522] Dynamic subtest vf-last: FAIL (0.482s)
[110.603435] Subtest bind-unbind-vf: FAIL (0.527s)
[110.637454] [026/133] (911s left) kms_vrr (lobf)
[110.746864] Starting subtest: lobf
[110.750142] Subtest lobf: SKIP (0.000s)
[110.814414] [027/133] (911s left) gem_mmap_offset (oob-read)
[110.869948] Starting subtest: oob-read
[110.872274] Subtest oob-read: SUCCESS (0.000s)
[110.980658] [028/133] (911s left) kms_psr (fbc-psr2-dpms)
[111.078054] Starting subtest: fbc-psr2-dpms
[111.080088] Starting dynamic subtest: eDP-1
[111.083578] Dynamic subtest eDP-1: SKIP (0.000s)
[111.087109] Subtest fbc-psr2-dpms: SKIP (0.001s)
[111.150039] [029/133] (911s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[111.242500] Starting subtest: 2x-absolute-wf_vblank-interruptible
[111.254655] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[111.327521] [030/133] (911s left) kms_chamelium_frames (hdmi-crc-fast)
[111.708650] Subtest hdmi-crc-fast: SKIP (0.000s)
[112.513318] [031/133] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[112.608296] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[112.612539] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[112.735276] [032/133] (909s left) kms_pm_rpm (cursor-dpms)
[114.259807] Starting subtest: cursor-dpms
[114.264957] Subtest cursor-dpms: SKIP (0.000s)
[114.975889] [033/133] (907s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[115.078270] Starting subtest: x-tiled-32bpp-rotate-90
[115.097222] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[115.217434] [034/133] (907s left) perf_pmu (busy-idle-no-semaphores)
[115.260208] Starting subtest: busy-idle-no-semaphores
[115.262398] Starting dynamic subtest: rcs0
[115.911742] Dynamic subtest rcs0: SUCCESS (0.652s)
[115.922748] Starting dynamic subtest: bcs0
[116.564144] Dynamic subtest bcs0: SUCCESS (0.651s)
[116.574953] Starting dynamic subtest: vcs0
[117.216782] Dynamic subtest vcs0: SUCCESS (0.651s)
[117.227531] Starting dynamic subtest: vcs1
[118.527053] Dynamic subtest vcs1: SUCCESS (1.309s)
[118.537692] Starting dynamic subtest: vecs0
[120.510928] Dynamic subtest vecs0: SUCCESS (1.982s)
[120.521809] Starting dynamic subtest: ccs0
[122.559679] Dynamic subtest ccs0: SUCCESS (2.047s)
[122.562275] Subtest busy-idle-no-semaphores: SUCCESS (7.300s)
[122.676634] [035/133] (900s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[122.785471] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[122.789477] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[122.874570] [036/133] (899s left) kms_invalid_mode (bad-htotal)
[122.966391] Starting subtest: bad-htotal
[122.968753] Starting dynamic subtest: pipe-A-eDP-1
[123.265631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[123.275756] Starting dynamic subtest: pipe-B-eDP-1
[123.277752] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[123.284774] Starting dynamic subtest: pipe-C-eDP-1
[123.287080] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[123.294519] Starting dynamic subtest: pipe-D-eDP-1
[123.296774] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[123.298955] Subtest bad-htotal: SUCCESS (0.306s)
[124.091092] [037/133] (898s left) gen9_exec_parse (basic-rejected)
[124.147826] Subtest basic-rejected: SKIP (0.000s)
[124.205986] [038/133] (898s left) kms_frontbuffer_tracking (fbc-suspend)
[124.302138] Starting subtest: fbc-suspend
[162.786619] Subtest fbc-suspend: SUCCESS (7.560s)
[163.977877] [039/133] (858s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[164.076466] Starting subtest: primary-x-tiled-reflect-x-0
[171.227485] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.144s)
[172.463963] [040/133] (850s left) gem_exec_fence (syncobj-channel)
[172.963290] Starting subtest: syncobj-channel
[173.983900] Subtest syncobj-channel: SUCCESS (1.015s)
[174.899958] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[174.903904] [041/133] (848s left) i915_hangman (engine-error-state-capture)
[174.971420] Starting subtest: engine-error-state-capture
[174.973289] Starting dynamic subtest: rcs0
[178.813700] Dynamic subtest rcs0: SUCCESS (3.840s)
[178.825617] Starting dynamic subtest: bcs0
[184.766019] Dynamic subtest bcs0: SUCCESS (5.947s)
[184.782454] Starting dynamic subtest: vcs0
[190.717218] Dynamic subtest vcs0: SUCCESS (5.947s)
[190.731978] Starting dynamic subtest: vcs1
[195.773698] Dynamic subtest vcs1: SUCCESS (5.052s)
[195.785874] Starting dynamic subtest: vecs0
[201.725696] Dynamic subtest vecs0: SUCCESS (5.947s)
[201.737539] Starting dynamic subtest: ccs0
[206.782072] Dynamic subtest ccs0: SUCCESS (5.052s)
[206.785276] Subtest engine-error-state-capture: SUCCESS (31.796s)
[206.878364] [042/133] (816s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[206.983218] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[206.985210] Starting dynamic subtest: pipe-A
[207.320792] Dynamic subtest pipe-A: SUCCESS (0.340s)
[207.330566] Starting dynamic subtest: pipe-B
[208.761833] Dynamic subtest pipe-B: SUCCESS (1.440s)
[208.770719] Starting dynamic subtest: pipe-C
[210.191457] Dynamic subtest pipe-C: SUCCESS (1.428s)
[210.201757] Starting dynamic subtest: pipe-D
[211.615208] Dynamic subtest pipe-D: SUCCESS (1.422s)
[211.617565] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.633s)
[212.814533] [043/133] (810s left) kms_cursor_edge_walk (128x128-top-edge)
[212.908424] Starting subtest: 128x128-top-edge
[212.910812] Starting dynamic subtest: pipe-A-eDP-1
[217.080952] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.169s)
[217.092248] Starting dynamic subtest: pipe-D-eDP-1
[219.764359] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.683s)
[219.766656] Subtest 128x128-top-edge: SUCCESS (6.855s)
[220.570777] [044/133] (802s left) gem_pxp (hw-rejects-pxp-context)
[220.689436] Starting subtest: hw-rejects-pxp-context
[220.694217] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[220.807771] [045/133] (802s left) gem_busy (parallel)
[220.996018] Starting subtest: parallel
[220.998726] Starting dynamic subtest: rcs0
[222.815483] Dynamic subtest rcs0: SUCCESS (1.817s)
[222.831642] Starting dynamic subtest: bcs0
[224.799658] Dynamic subtest bcs0: SUCCESS (1.981s)
[224.811858] Starting dynamic subtest: vcs0
[226.784224] Dynamic subtest vcs0: SUCCESS (1.981s)
[226.796131] Starting dynamic subtest: vcs1
[228.885702] Dynamic subtest vcs1: SUCCESS (2.044s)
[228.898086] Starting dynamic subtest: vecs0
[230.816011] Dynamic subtest vecs0: SUCCESS (1.981s)
[230.827668] Starting dynamic subtest: ccs0
[232.798969] Dynamic subtest ccs0: SUCCESS (1.980s)
[232.802063] Subtest parallel: SUCCESS (11.797s)
[233.043797] [046/133] (790s left) kms_pm_rpm (pm-tiling)
[234.913389] Starting subtest: pm-tiling
[234.918333] Subtest pm-tiling: SKIP (0.000s)
[235.318687] [047/133] (787s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[235.416215] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[235.418529] Starting dynamic subtest: pipe-A-eDP-1
[235.513648] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[235.524554] Starting dynamic subtest: pipe-B-eDP-1
[236.691870] Dynamic subtest pipe-B-eDP-1: SKIP (1.173s)
[236.696588] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.276s)
[237.873001] [048/133] (785s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[237.997365] Starting subtest: flip-vs-cursor-atomic
[245.505803] Subtest flip-vs-cursor-atomic: SUCCESS (7.503s)
[246.304261] [049/133] (777s left) kms_psr (fbc-psr-sprite-render)
[246.414668] Starting subtest: fbc-psr-sprite-render
[246.416929] Starting dynamic subtest: eDP-1
[246.421270] Dynamic subtest eDP-1: SKIP (0.000s)
[246.425466] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[246.488659] [050/133] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[246.597186] Starting subtest: psr-1p-primscrn-cur-indfb-move
[254.031079] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.434s)
[254.146475] [051/133] (769s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[254.236890] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[254.240820] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[254.309635] [052/133] (769s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[254.401465] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[254.405782] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[254.491759] [053/133] (769s left) kms_cdclk (mode-transition-all-outputs)
[254.576373] Starting subtest: mode-transition-all-outputs
[254.868515] Subtest mode-transition-all-outputs: SKIP (0.289s)
[255.665487] [054/133] (767s left) sysfs_timeslice_duration (duration)
[255.734960] Starting subtest: duration
[255.737773] Starting dynamic subtest: vecs0
[270.717256] Dynamic subtest vecs0: SUCCESS (14.973s)
[270.728893] Starting dynamic subtest: ccs0
[283.879195] Dynamic subtest ccs0: SUCCESS (13.149s)
[283.889588] Starting dynamic subtest: vcs0
[298.749967] Dynamic subtest vcs0: SUCCESS (14.866s)
[298.765319] Starting dynamic subtest: bcs0
[311.901707] Dynamic subtest bcs0: SUCCESS (13.145s)
[311.920387] Starting dynamic subtest: rcs0
[325.065731] Dynamic subtest rcs0: SUCCESS (13.153s)
[325.078049] Starting dynamic subtest: vcs1
[338.751036] Dynamic subtest vcs1: SUCCESS (13.677s)
[338.754091] Subtest duration: SUCCESS (82.978s)
[338.830569] [055/133] (684s left) gem_eio (wait-1us)
[339.043618] Starting subtest: wait-1us
[339.333395] Subtest wait-1us: SUCCESS (0.291s)
[339.455397] [056/133] (684s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[339.568554] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[339.572813] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[339.670777] [057/133] (684s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[339.755983] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[344.296879] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.543s)
[345.519760] [058/133] (678s left) prime_vgem (basic-write)
[345.581073] Starting subtest: basic-write
[345.592545] Subtest basic-write: SKIP (0.009s)
[345.708561] [059/133] (678s left) gen3_render_tiledx_blits
[345.826626] [060/133] (678s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[345.921776] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[345.924212] Starting dynamic subtest: pipe-A-eDP-1
[346.087723] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.157s)
[346.104162] Starting dynamic subtest: pipe-B-eDP-1
[346.124844] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[346.134461] Starting dynamic subtest: pipe-C-eDP-1
[346.153180] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[346.161711] Starting dynamic subtest: pipe-D-eDP-1
[346.180506] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[346.182631] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.167s)
[348.379184] [061/133] (675s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[348.436428] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[348.537911] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[348.618722] [062/133] (675s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[348.712948] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[348.717277] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[348.787299] [063/133] (675s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[348.889717] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[348.891963] Starting dynamic subtest: pipe-A-eDP-1
[348.962801] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[348.974417] Starting dynamic subtest: pipe-B-eDP-1
[350.049703] Dynamic subtest pipe-B-eDP-1: SKIP (1.084s)
[350.054341] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.165s)
[351.240678] [064/133] (672s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[351.340593] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[351.344714] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[351.436854] [065/133] (672s left) gem_lmem_swapping (parallel-multi)
[351.483401] Subtest parallel-multi: SKIP (0.000s)
[351.524759] [066/133] (672s left) gem_exec_parallel (fds)
[351.579627] Starting subtest: fds
[351.581981] Starting dynamic subtest: rcs0
[355.269488] Dynamic subtest rcs0: SUCCESS (3.689s)
[355.281212] Starting dynamic subtest: bcs0
[359.194375] Dynamic subtest bcs0: SUCCESS (3.920s)
[359.206453] Starting dynamic subtest: vcs0
[363.166086] Dynamic subtest vcs0: SUCCESS (3.967s)
[363.175590] Starting dynamic subtest: vcs1
[367.107364] Dynamic subtest vcs1: SUCCESS (3.937s)
[367.120071] Starting dynamic subtest: vecs0
[371.117199] Dynamic subtest vecs0: SUCCESS (4.007s)
[371.126911] Starting dynamic subtest: ccs0
[375.385378] Dynamic subtest ccs0: SUCCESS (4.263s)
[375.388773] Subtest fds: SUCCESS (23.798s)
[375.597933] [067/133] (648s left) kms_scaling_modes (scaling-mode-full-aspect)
[375.691210] Starting subtest: scaling-mode-full-aspect
[375.693180] Starting dynamic subtest: pipe-A-eDP-1
[375.789204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.099s)
[375.799920] Starting dynamic subtest: pipe-B-eDP-1
[376.961780] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s)
[376.972399] Starting dynamic subtest: pipe-C-eDP-1
[378.191918] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s)
[378.201886] Starting dynamic subtest: pipe-D-eDP-1
[379.324200] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[379.326445] Subtest scaling-mode-full-aspect: SUCCESS (3.634s)
[380.503734] [068/133] (643s left) i915_drm_fdinfo (busy-hang)
[380.543916] Starting subtest: busy-hang
[380.545955] Starting dynamic subtest: rcs0
[380.567048] Dynamic subtest rcs0: SKIP (0.022s)
[380.578875] Starting dynamic subtest: bcs0
[380.583396] Dynamic subtest bcs0: SKIP (0.001s)
[380.592746] Starting dynamic subtest: vcs0
[380.597210] Dynamic subtest vcs0: SKIP (0.000s)
[380.606105] Starting dynamic subtest: vcs1
[380.610388] Dynamic subtest vcs1: SKIP (0.000s)
[380.619246] Starting dynamic subtest: vecs0
[380.623455] Dynamic subtest vecs0: SKIP (0.000s)
[380.632464] Starting dynamic subtest: ccs0
[380.636553] Dynamic subtest ccs0: SKIP (0.001s)
[380.640613] Subtest busy-hang: SKIP (0.028s)
[380.692084] [069/133] (643s left) kms_vblank (wait-forked)
[380.782071] Starting subtest: wait-forked
[380.783921] Starting dynamic subtest: pipe-A-eDP-1
[382.618769] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.834s)
[382.634968] Starting dynamic subtest: pipe-D-eDP-1
[385.096722] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.477s)
[385.099110] Subtest wait-forked: SUCCESS (4.315s)
[385.955820] [070/133] (638s left) kms_lease (atomic-implicit-crtc)
[386.047235] Starting subtest: atomic-implicit-crtc
[386.049585] Starting dynamic subtest: pipe-A-eDP-1
[386.060891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[386.072053] Starting dynamic subtest: pipe-B-eDP-1
[386.083948] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[386.096974] Starting dynamic subtest: pipe-C-eDP-1
[386.107406] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[386.115953] Starting dynamic subtest: pipe-D-eDP-1
[386.126445] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[386.128328] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[386.204643] [071/133] (638s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[386.298818] Starting subtest: fbcpsr-tiling-4
[393.406008] Subtest fbcpsr-tiling-4: SUCCESS (7.104s)
[393.560086] [072/133] (630s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[393.665022] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[394.767598] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.102s)
[394.881791] [073/133] (629s left) gem_eio (in-flight-immediate)
[395.121779] Starting subtest: in-flight-immediate
[403.716392] Subtest in-flight-immediate: SUCCESS (8.590s)
[403.878771] [074/133] (620s left) gem_exec_reloc (basic-active)
[403.969481] Subtest basic-active: SKIP (0.000s)
[404.041786] [075/133] (620s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[404.170397] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[404.174683] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[404.317905] [076/133] (620s left) syncobj_timeline (wait-all-complex)
[404.380608] Starting subtest: wait-all-complex
[404.596178] Subtest wait-all-complex: SUCCESS (0.214s)
[404.672613] [077/133] (619s left) gem_exec_fence (basic-busy)
[404.847783] Starting subtest: basic-busy
[404.850231] Starting dynamic subtest: rcs0
[404.931922] Dynamic subtest rcs0: SUCCESS (0.087s)
[404.943916] Starting dynamic subtest: bcs0
[404.988831] Dynamic subtest bcs0: SUCCESS (0.055s)
[405.000761] Starting dynamic subtest: vcs0
[405.042260] Dynamic subtest vcs0: SUCCESS (0.052s)
[405.053311] Starting dynamic subtest: vcs1
[405.099384] Dynamic subtest vcs1: SUCCESS (0.055s)
[405.110544] Starting dynamic subtest: vecs0
[405.152388] Dynamic subtest vecs0: SUCCESS (0.051s)
[405.164068] Starting dynamic subtest: ccs0
[405.206347] Dynamic subtest ccs0: SUCCESS (0.052s)
[405.208861] Subtest basic-busy: SUCCESS (0.364s)
[406.901130] [078/133] (617s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[406.966484] Starting subtest: rel-constants-invalid-rel-gen5
[406.968745] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[407.064330] [079/133] (617s left) gem_ccs (suspend-resume)
[407.126005] Starting subtest: suspend-resume
[407.130440] Subtest suspend-resume: SKIP (0.000s)
[407.227854] [080/133] (617s left) gem_ctx_param (get-priority-new-ctx)
[407.272857] Starting subtest: get-priority-new-ctx
[407.274966] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[407.399804] [081/133] (617s left) gem_softpin (allocator-nopin-reserve)
[407.455923] Starting subtest: allocator-nopin-reserve
[407.549986] Subtest allocator-nopin-reserve: SUCCESS (0.094s)
[407.670751] [082/133] (617s left) kms_psr (psr2-sprite-plane-onoff)
[407.769822] Starting subtest: psr2-sprite-plane-onoff
[407.772079] Starting dynamic subtest: eDP-1
[409.495048] Dynamic subtest eDP-1: SUCCESS (1.725s)
[409.497479] Subtest psr2-sprite-plane-onoff: SUCCESS (1.726s)
[410.372813] [083/133] (614s left) syncobj_wait (wait-for-submit-complex)
[410.425400] Starting subtest: wait-for-submit-complex
[410.485962] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[410.567310] [084/133] (614s left) syncobj_timeline (host-signal-points)
[410.618151] Starting subtest: host-signal-points
[410.622981] Subtest host-signal-points: SUCCESS (0.004s)
[410.706060] [085/133] (614s left) gem_ctx_sseu (invalid-sseu)
[410.769775] Subtest invalid-sseu: SKIP (0.000s)
[410.834338] [086/133] (614s left) syncobj_wait (invalid-reset-one-illegal-handle)
[410.896661] Starting subtest: invalid-reset-one-illegal-handle
[410.899047] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[410.990036] [087/133] (614s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[411.093889] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[411.096127] Starting dynamic subtest: pipe-A-default-mode
[413.815246] Dynamic subtest pipe-A-default-mode: SUCCESS (2.720s)
[413.817542] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.721s)
[414.642069] [088/133] (610s left) gem_exec_schedule (preempt-queue)
[414.716928] Subtest preempt-queue: SKIP (0.000s)
[415.006309] [089/133] (610s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[415.096307] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[415.100560] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[415.205014] [090/133] (609s left) prime_self_import (basic-with_one_bo)
[415.239800] Starting subtest: basic-with_one_bo
[415.250183] Subtest basic-with_one_bo: SUCCESS (0.014s)
[415.365717] [091/133] (609s left) kms_addfb_basic (unused-pitches)
[415.432576] Starting subtest: unused-pitches
[415.434564] Subtest unused-pitches: SUCCESS (0.000s)
[415.558548] [092/133] (609s left) i915_suspend (basic-s3-without-i915)
[415.599066] Starting subtest: basic-s3-without-i915
[417.307446] Subtest basic-s3-without-i915: SKIP (1.704s)
[418.886538] [093/133] (606s left) syncobj_wait (invalid-single-wait-unsubmitted)
[418.957052] Starting subtest: invalid-single-wait-unsubmitted
[418.959452] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[419.049068] [094/133] (606s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[419.142926] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[419.146788] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[419.213006] [095/133] (606s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[419.298019] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[419.300337] Starting dynamic subtest: pipe-A-eDP-1
[419.326761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.026s)
[419.335720] Starting dynamic subtest: pipe-B-eDP-1
[419.355848] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[419.364270] Starting dynamic subtest: pipe-C-eDP-1
[419.383434] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[419.393054] Starting dynamic subtest: pipe-D-eDP-1
[419.414277] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[419.416896] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.098s)
[421.651621] [096/133] (603s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[421.787760] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[432.985176] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.191s)
[433.786049] [097/133] (591s left) kms_flip (2x-flip-vs-panning)
[433.886762] Starting subtest: 2x-flip-vs-panning
[433.896377] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[433.976608] [098/133] (591s left) gem_exec_balancer (bonded-false-hang)
[434.238681] Starting subtest: bonded-false-hang
[434.243570] Subtest bonded-false-hang: SKIP (0.000s)
[434.332363] [099/133] (591s left) gem_exec_schedule (preempt-self)
[434.399842] Starting subtest: preempt-self
[434.402219] Starting dynamic subtest: rcs0
[434.415450] Dynamic subtest rcs0: SUCCESS (0.024s)
[434.426146] Starting dynamic subtest: bcs0
[434.431742] Dynamic subtest bcs0: SUCCESS (0.016s)
[434.440712] Starting dynamic subtest: vcs0
[434.447620] Dynamic subtest vcs0: SUCCESS (0.015s)
[434.456117] Starting dynamic subtest: vcs1
[434.462668] Dynamic subtest vcs1: SUCCESS (0.014s)
[434.470845] Starting dynamic subtest: vecs0
[434.483258] Dynamic subtest vecs0: SUCCESS (0.020s)
[434.491784] Starting dynamic subtest: ccs0
[434.500925] Dynamic subtest ccs0: SUCCESS (0.017s)
[434.503205] Subtest preempt-self: SUCCESS (0.111s)
[435.897115] [100/133] (589s left) kms_plane_lowres (tiling-none)
[435.986379] Starting subtest: tiling-none
[435.988607] Starting dynamic subtest: pipe-A-eDP-1
[435.992977] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[436.288791] Starting dynamic subtest: pipe-B-eDP-1
[436.293219] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[436.301409] Starting dynamic subtest: pipe-C-eDP-1
[436.305953] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[436.314825] Starting dynamic subtest: pipe-D-eDP-1
[436.319598] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[436.323647] Subtest tiling-none: SKIP (0.303s)
[437.113203] [101/133] (588s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[437.178718] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[437.182838] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[437.360122] [102/133] (588s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[437.450484] Starting subtest: 2x-flip-vs-modeset-vs-hang
[437.454842] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.002s)
[437.585826] [103/133] (588s left) kms_pm_backlight (bad-brightness)
[437.683070] Starting subtest: bad-brightness
[437.739573] Starting dynamic subtest: eDP-1
[438.046963] Dynamic subtest eDP-1: SUCCESS (0.307s)
[438.048843] Subtest bad-brightness: SUCCESS (0.361s)
[438.854369] [104/133] (586s left) kms_addfb_basic (invalid-get-prop-any)
[438.917764] Starting subtest: invalid-get-prop-any
[438.920183] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[439.061321] [105/133] (586s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[439.121841] Starting subtest: invalid-smem-bo-on-discrete
[439.126242] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[439.258700] [106/133] (586s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[439.369373] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[446.958451] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.587s)
[447.104295] [107/133] (578s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[447.214691] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[454.625041] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.410s)
[454.763388] [108/133] (571s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[454.865213] Starting subtest: dsc-fractional-bpp-with-bpc
[454.895047] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[454.937279] [109/133] (571s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[455.036256] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[455.040342] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[455.132127] [110/133] (570s left) api_intel_allocator (alloc-simple)
[455.181039] Starting subtest: alloc-simple
[455.183399] Subtest alloc-simple: SUCCESS (0.003s)
[455.304380] [111/133] (570s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[455.399470] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[455.403695] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[455.499853] [112/133] (570s left) gem_close_race (basic-process)
[455.569818] Starting subtest: basic-process
[455.617875] Subtest basic-process: SUCCESS (0.050s)
[455.802770] [113/133] (570s left) dmabuf_sync_file (export-basic)
[455.853768] Starting subtest: export-basic
[455.856190] Subtest export-basic: SUCCESS (0.001s)
[455.913133] [114/133] (570s left) kms_plane_alpha_blend (coverage-7efc)
[455.997510] Starting subtest: coverage-7efc
[456.281379] Starting dynamic subtest: pipe-A-eDP-1
[456.863546] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[456.888992] Starting dynamic subtest: pipe-D-eDP-1
[458.191688] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s)
[458.193814] Subtest coverage-7efc: SUCCESS (2.194s)
[459.016306] [115/133] (567s left) gem_watchdog (default-virtual)
[459.091821] Starting subtest: default-virtual
[465.367999] Subtest default-virtual: SUCCESS (6.284s)
[465.460583] [116/133] (560s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[465.588509] Starting subtest: y-tiled-32bpp-rotate-180
[465.592767] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[465.689413] [117/133] (560s left) kms_psr (fbc-psr-primary-blt)
[465.787199] Starting subtest: fbc-psr-primary-blt
[465.789440] Starting dynamic subtest: eDP-1
[465.793719] Dynamic subtest eDP-1: SKIP (0.000s)
[465.797881] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[465.859621] [118/133] (560s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[465.965431] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[475.248601] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.281s)
[475.386128] [119/133] (550s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[475.498930] Starting subtest: cursorB-vs-flipA-atomic
[475.503354] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[475.656022] [120/133] (550s left) api_intel_bb (intel-bb-blit-x)
[475.709128] Starting subtest: intel-bb-blit-x
[479.477798] Subtest intel-bb-blit-x: SUCCESS (3.767s)
[479.587290] [121/133] (546s left) i915_pm_rps (engine-order)
[479.655378] Starting subtest: engine-order
[484.534915] Subtest engine-order: SUCCESS (4.874s)
[484.645293] [122/133] (541s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[484.751791] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[493.392482] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.640s)
[493.493262] [123/133] (533s left) kms_chamelium_hpd (vga-hpd)
[493.881253] Subtest vga-hpd: SKIP (0.000s)
[494.672353] [124/133] (531s left) gem_pxp (create-protected-buffer)
[494.811613] Starting subtest: create-protected-buffer
[494.814099] Subtest create-protected-buffer: SUCCESS (0.000s)
[494.932300] [125/133] (531s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[495.046796] Starting subtest: psr2-overlay-plane-update-continuous-sf
[495.049112] Starting dynamic subtest: pipe-A-eDP-1
[496.183427] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.139s)
[496.192568] Starting dynamic subtest: pipe-B-eDP-1
[497.942593] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.759s)
[497.944806] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.901s)
[498.756982] [126/133] (527s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[498.854252] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[498.864308] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[498.956130] [127/133] (527s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[499.065396] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[499.715022] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.650s)
[499.887850] [128/133] (526s left) gem_exec_schedule (u-submit-golden-slice)
[499.967748] Starting subtest: u-submit-golden-slice
[499.969750] Starting dynamic subtest: rcs0
[499.996670] Dynamic subtest rcs0: SUCCESS (0.038s)
[500.010903] Starting dynamic subtest: bcs0
[500.029874] Dynamic subtest bcs0: SUCCESS (0.031s)
[500.041008] Starting dynamic subtest: vcs0
[500.062207] Dynamic subtest vcs0: SUCCESS (0.032s)
[500.071341] Starting dynamic subtest: vcs1
[500.090568] Dynamic subtest vcs1: SUCCESS (0.027s)
[500.099567] Starting dynamic subtest: vecs0
[500.120310] Dynamic subtest vecs0: SUCCESS (0.029s)
[500.132715] Starting dynamic subtest: ccs0
[500.153943] Dynamic subtest ccs0: SUCCESS (0.033s)
[500.156077] Subtest u-submit-golden-slice: SUCCESS (0.196s)
[501.940498] [129/133] (524s left) syncobj_timeline (invalid-wait-illegal-handle)
[501.991077] Starting subtest: invalid-wait-illegal-handle
[501.993366] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[502.087521] [130/133] (524s left) gem_workarounds (reset-context)
[502.144318] Starting subtest: reset-context
[502.324636] Subtest reset-context: SUCCESS (0.180s)
[502.445271] [131/133] (524s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[502.555844] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[503.381053] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s)
[503.554345] [132/133] (523s left) kms_cursor_crc (cursor-onscreen-32x32)
[503.691828] Starting subtest: cursor-onscreen-32x32
[503.740675] Subtest cursor-onscreen-32x32: SKIP (0.044s)
[504.018878] [133/133] (522s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[504.123355] Starting subtest: fbcpsr-modesetfrombusy
[510.350590] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.230s)
[510.501427] Closing watchdogs
results: parsing output: 0/ for test: syncobj_basic
results: parsing output: 1/ for test: gem_exec_parallel
results: parsing output: 2/ for test: gem_ctx_persistence
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_universal_plane
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_atomic
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: gem_mmap
results: parsing output: 13/ for test: kms_color_pipeline
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gem_exec_flush
results: parsing output: 17/ for test: gem_render_copy_redux
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_dirtyfb
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_setmode
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: sriov_basic
results: parsing output: 25/ for test: kms_vrr
results: parsing output: 26/ for test: gem_mmap_offset
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_chamelium_frames
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_invalid_mode
results: parsing output: 36/ for test: gen9_exec_parse
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_rotation_crc
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_cursor_edge_walk
results: parsing output: 43/ for test: gem_pxp
results: parsing output: 44/ for test: gem_busy
results: parsing output: 45/ for test: kms_pm_rpm
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cdclk
results: parsing output: 53/ for test: sysfs_timeslice_duration
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: prime_vgem
results: parsing output: 58/ for test: gen3_render_tiledx_blits
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_lmem_swapping
results: parsing output: 65/ for test: gem_exec_parallel
results: parsing output: 66/ for test: kms_scaling_modes
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: kms_lease
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_exec_fence
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: gem_ccs
results: parsing output: 79/ for test: gem_ctx_param
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_ctx_sseu
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: prime_self_import
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: i915_suspend
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_plane_lowres
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_pm_backlight
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_dsc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_close_race
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: kms_plane_alpha_blend
results: parsing output: 114/ for test: gem_watchdog
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: i915_pm_rps
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_workarounds
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.