[58.989887] Initializing watchdogs
[58.989942]   /dev/watchdog0
[59.004420] [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]
[59.008947] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.011863] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.015298] [001/133] (960s left) kms_pm_rpm (dpms-non-lpsp)
[61.095769] Starting subtest: dpms-non-lpsp
[61.100871] Subtest dpms-non-lpsp: SKIP (0.001s)
[61.466345] [002/133] (958s left) kms_chamelium_frames (hdmi-aspect-ratio)
[61.848899] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[62.643055] [003/133] (956s left) gem_ctx_persistence (legacy-engines-persistence)
[62.703880] Starting subtest: legacy-engines-persistence
[62.706309] Starting dynamic subtest: render
[63.517288] Dynamic subtest render: SUCCESS (0.817s)
[63.531397] Starting dynamic subtest: bsd1
[64.276470] Dynamic subtest bsd1: SUCCESS (0.759s)
[64.286461] Starting dynamic subtest: bsd2
[65.036847] Dynamic subtest bsd2: SUCCESS (0.761s)
[65.046187] Starting dynamic subtest: blt
[65.809820] Dynamic subtest blt: SUCCESS (0.774s)
[65.820862] Starting dynamic subtest: vebox
[66.570307] Dynamic subtest vebox: SUCCESS (0.761s)
[66.573050] Subtest legacy-engines-persistence: SUCCESS (3.883s)
[66.647821] [004/133] (952s left) api_intel_allocator (alloc-simple)
[66.785032] Starting subtest: alloc-simple
[66.791438] Subtest alloc-simple: SUCCESS (0.008s)
[66.988162] [005/133] (952s left) kms_psr (psr2-sprite-blt)
[67.327090] Starting subtest: psr2-sprite-blt
[67.329512] Starting dynamic subtest: eDP-1
[69.038744] Dynamic subtest eDP-1: SUCCESS (1.715s)
[69.040817] Subtest psr2-sprite-blt: SUCCESS (1.716s)
[69.897620] [006/133] (949s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[69.992697] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[69.997228] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[70.061894] [007/133] (949s left) gem_exec_params (invalid-bsd1-flag-on-render)
[70.113919] Starting subtest: invalid-bsd1-flag-on-render
[70.116297] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[70.224251] [008/133] (949s left) sw_sync (sync_multi_producer_single_consumer)
[70.261940] Starting subtest: sync_multi_producer_single_consumer
[71.335933] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[71.392553] [009/133] (948s left) i915_suspend (fence-restore-tiled2untiled)
[71.451819] Starting subtest: fence-restore-tiled2untiled
[71.456729] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[71.549871] [010/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[71.639233] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[71.643688] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[71.729096] [011/133] (948s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[71.800146] Starting subtest: map-fixed-invalidate-overlap
[71.804431] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[71.921903] [012/133] (948s left) gem_exec_capture (userptr)
[71.979917] Starting subtest: userptr
[72.810491] Subtest userptr: SUCCESS (0.830s)
[72.916319] [013/133] (947s left) kms_dsc (dsc-with-bpc-formats)
[73.004152] Starting subtest: dsc-with-bpc-formats
[73.115723] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[73.153936] [014/133] (946s left) gem_userptr_blits (unsync-overlap)
[73.220720] Subtest unsync-overlap: SKIP (0.000s)
[73.330195] [015/133] (946s left) gem_softpin (evict-prime)
[73.388011] Starting subtest: evict-prime
[73.390446] Starting dynamic subtest: rcs0
[74.533981] Dynamic subtest rcs0: SUCCESS (1.147s)
[74.544380] Starting dynamic subtest: bcs0
[75.647650] Dynamic subtest bcs0: SUCCESS (1.114s)
[75.656977] Starting dynamic subtest: vcs0
[76.885922] Dynamic subtest vcs0: SUCCESS (1.237s)
[76.896066] Starting dynamic subtest: vcs1
[78.879489] Dynamic subtest vcs1: SUCCESS (1.993s)
[78.890375] Starting dynamic subtest: vecs0
[80.852199] Dynamic subtest vecs0: SUCCESS (1.971s)
[80.862895] Starting dynamic subtest: ccs0
[81.976777] Dynamic subtest ccs0: SUCCESS (1.125s)
[81.986384] Starting dynamic subtest: all
[83.927869] Dynamic subtest all: SUCCESS (1.948s)
[83.930935] Subtest evict-prime: SUCCESS (10.540s)
[84.007489] [016/133] (936s left) gem_cs_tlb (engines)
[84.069244] Starting subtest: engines
[84.071212] Starting dynamic subtest: rcs0
[86.226828] Dynamic subtest rcs0: SUCCESS (2.154s)
[86.235248] Starting dynamic subtest: bcs0
[88.381079] Dynamic subtest bcs0: SUCCESS (2.153s)
[88.391060] Starting dynamic subtest: vcs0
[90.533951] Dynamic subtest vcs0: SUCCESS (2.152s)
[90.541338] Starting dynamic subtest: vcs1
[92.685800] Dynamic subtest vcs1: SUCCESS (2.151s)
[92.694444] Starting dynamic subtest: vecs0
[94.838670] Dynamic subtest vecs0: SUCCESS (2.152s)
[94.846786] Starting dynamic subtest: ccs0
[96.993222] Dynamic subtest ccs0: SUCCESS (2.153s)
[96.995166] Subtest engines: SUCCESS (12.917s)
[97.096030] [017/133] (923s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[97.216231] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[97.220340] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[97.307231] [018/133] (922s left) kms_panel_fitting (atomic-fastset)
[97.391501] Starting subtest: atomic-fastset
[97.393805] Starting dynamic subtest: pipe-A-eDP-1
[97.529222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s)
[97.539919] Starting dynamic subtest: pipe-B-eDP-1
[98.757188] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.227s)
[98.770870] Starting dynamic subtest: pipe-C-eDP-1
[99.946798] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.189s)
[99.955811] Starting dynamic subtest: pipe-D-eDP-1
[101.077640] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[101.079885] Subtest atomic-fastset: SUCCESS (3.686s)
[102.334164] [019/133] (917s left) gem_mmap_gtt (fault-concurrent)
[102.388722] Subtest fault-concurrent: SKIP (0.000s)
[102.462042] [020/133] (917s left) gem_caching (read-writes)
[102.523671] Subtest read-writes: SKIP (0.000s)
[102.594643] [021/133] (917s left) kms_flip (flip-vs-panning-vs-hang)
[102.680449] Starting subtest: flip-vs-panning-vs-hang
[102.682750] Starting dynamic subtest: A-eDP1
[153.408384] Dynamic subtest A-eDP1: SUCCESS (50.727s)
[153.419342] Starting dynamic subtest: D-eDP1
[202.367582] Dynamic subtest D-eDP1: SUCCESS (48.956s)
[202.370069] Subtest flip-vs-panning-vs-hang: SUCCESS (99.686s)
[203.525332] [022/133] (816s left) gem_exec_reloc (basic-write-gtt-active)
[203.584067] Subtest basic-write-gtt-active: SKIP (0.000s)
[203.639022] [023/133] (816s left) kms_lease (lease-invalid-plane)
[203.721571] Starting subtest: lease-invalid-plane
[203.723876] Starting dynamic subtest: pipe-A-eDP-1
[203.726270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[203.735285] Starting dynamic subtest: pipe-B-eDP-1
[203.737481] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[203.744652] Starting dynamic subtest: pipe-C-eDP-1
[203.746564] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[203.753726] Starting dynamic subtest: pipe-D-eDP-1
[203.755787] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[203.757928] Subtest lease-invalid-plane: SUCCESS (0.003s)
[203.794450] [024/133] (816s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[203.854759] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[203.856865] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[203.951014] [025/133] (816s left) dmabuf_sync_file (import-basic)
[204.064176] Starting subtest: import-basic
[204.066138] Subtest import-basic: SUCCESS (0.003s)
[204.114085] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[204.117130] [026/133] (816s left) kms_color (ctm-0-75)
[204.218222] Starting subtest: ctm-0-75
[204.220436] Starting dynamic subtest: pipe-A-eDP-1
[209.170639] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.952s)
[209.178735] Starting dynamic subtest: pipe-B-eDP-1
[214.876712] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.706s)
[214.886188] Starting dynamic subtest: pipe-C-eDP-1
[220.181313] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.306s)
[220.193645] Starting dynamic subtest: pipe-D-eDP-1
[225.485500] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.301s)
[225.487412] Subtest ctm-0-75: SUCCESS (21.266s)
[226.308741] [027/133] (794s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[226.422596] Starting subtest: cursorA-vs-flipA-atomic-transitions
[237.590145] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.168s)
[238.438384] [028/133] (782s left) gem_exec_params (rel-constants-invalid-ring)
[238.507686] Starting subtest: rel-constants-invalid-ring
[238.510054] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[238.608685] [029/133] (782s left) kms_pm_rpm (modeset-non-lpsp-stress)
[240.127348] Starting subtest: modeset-non-lpsp-stress
[241.285266] Subtest modeset-non-lpsp-stress: SKIP (1.155s)
[241.668828] [030/133] (778s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[241.766258] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[241.768625] Starting dynamic subtest: pipe-A-eDP-1
[241.777970] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[241.787169] Starting dynamic subtest: pipe-B-eDP-1
[241.796370] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[241.803810] Starting dynamic subtest: pipe-C-eDP-1
[241.812249] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[241.819060] Starting dynamic subtest: pipe-D-eDP-1
[241.827318] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[241.831273] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[244.033116] [031/133] (776s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[244.131078] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[244.133225] Starting dynamic subtest: pipe-A-eDP-1
[244.159334] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.167646] Starting dynamic subtest: pipe-B-eDP-1
[244.191186] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.198449] Starting dynamic subtest: pipe-C-eDP-1
[244.223470] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.230979] Starting dynamic subtest: pipe-D-eDP-1
[244.255287] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.259761] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[246.374552] [032/133] (774s left) kms_cursor_crc (cursor-onscreen-256x256)
[246.641722] Starting subtest: cursor-onscreen-256x256
[246.646496] Starting dynamic subtest: pipe-A-eDP-1
[248.823280] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.175s)
[248.851631] Starting dynamic subtest: pipe-D-eDP-1
[251.581641] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.734s)
[251.583791] Subtest cursor-onscreen-256x256: SUCCESS (4.937s)
[252.446560] [033/133] (768s left) i915_pm_rc6_residency (rc6-accuracy)
[252.497765] Starting subtest: rc6-accuracy
[252.499755] Starting dynamic subtest: gt0
[255.668966] Dynamic subtest gt0: SUCCESS (3.169s)
[255.677829] Starting dynamic subtest: gt1
[258.842674] Dynamic subtest gt1: SUCCESS (3.169s)
[258.845414] Subtest rc6-accuracy: SUCCESS (6.344s)
[258.921113] [034/133] (761s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[259.029400] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[259.033915] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[259.095577] [035/133] (761s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[259.192113] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[259.960835] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.770s)
[260.100200] [036/133] (760s left) gem_exec_fence (keep-in-fence)
[260.273660] Starting subtest: keep-in-fence
[260.276180] Starting dynamic subtest: rcs0
[260.328025] Dynamic subtest rcs0: SUCCESS (0.055s)
[260.338746] Starting dynamic subtest: bcs0
[260.380844] Dynamic subtest bcs0: SUCCESS (0.051s)
[260.390050] Starting dynamic subtest: vcs0
[261.909874] Dynamic subtest vcs0: SUCCESS (1.525s)
[261.920137] Starting dynamic subtest: vcs1
[263.894298] Dynamic subtest vcs1: SUCCESS (1.981s)
[263.904648] Starting dynamic subtest: vecs0
[265.941964] Dynamic subtest vecs0: SUCCESS (2.045s)
[265.952348] Starting dynamic subtest: ccs0
[266.163777] Dynamic subtest ccs0: SUCCESS (0.220s)
[266.166391] Subtest keep-in-fence: SUCCESS (5.891s)
[267.947274] [037/133] (752s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[268.052935] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[268.056824] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[268.142080] [038/133] (752s left) kms_plane_lowres (tiling-none)
[268.231161] Starting subtest: tiling-none
[268.233353] Starting dynamic subtest: pipe-A-eDP-1
[268.237969] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[268.540163] Starting dynamic subtest: pipe-B-eDP-1
[268.544775] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[268.554117] Starting dynamic subtest: pipe-C-eDP-1
[268.558586] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[268.566572] Starting dynamic subtest: pipe-D-eDP-1
[268.571365] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[268.575767] Subtest tiling-none: SKIP (0.310s)
[269.378250] [039/133] (751s left) gem_exec_schedule (preemptive-hang)
[269.563593] Starting subtest: preemptive-hang
[269.565789] Starting dynamic subtest: rcs0
[279.035906] Dynamic subtest rcs0: SUCCESS (9.475s)
[279.052145] Starting dynamic subtest: bcs0
[287.995846] Dynamic subtest bcs0: SUCCESS (8.957s)
[288.010164] Starting dynamic subtest: vcs0
[297.020707] Dynamic subtest vcs0: SUCCESS (9.023s)
[297.031391] Starting dynamic subtest: vcs1
[306.050083] Dynamic subtest vcs1: SUCCESS (9.024s)
[306.061473] Starting dynamic subtest: vecs0
[315.002048] Dynamic subtest vecs0: SUCCESS (8.952s)
[315.011758] Starting dynamic subtest: ccs0
[324.032419] Dynamic subtest ccs0: SUCCESS (9.033s)
[324.034812] Subtest preemptive-hang: SUCCESS (54.472s)
[324.275661] [040/133] (696s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[324.381576] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[324.385973] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[324.480746] [041/133] (696s left) kms_psr (fbc-psr2-dpms)
[324.569951] Starting subtest: fbc-psr2-dpms
[324.572217] Starting dynamic subtest: eDP-1
[324.576235] Dynamic subtest eDP-1: SKIP (0.000s)
[324.580303] Subtest fbc-psr2-dpms: SKIP (0.001s)
[324.644950] [042/133] (696s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[324.732151] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[324.736605] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[324.802975] [043/133] (696s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[324.900168] Starting subtest: 4-tiled-32bpp-rotate-270
[324.921429] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s)
[325.040921] [044/133] (696s left) gem_exec_schedule (submit-late-slice)
[325.106134] Starting subtest: submit-late-slice
[325.108066] Starting dynamic subtest: rcs0
[325.134805] Dynamic subtest rcs0: SUCCESS (0.036s)
[325.142677] Starting dynamic subtest: bcs0
[325.166020] Dynamic subtest bcs0: SUCCESS (0.030s)
[325.173716] Starting dynamic subtest: vcs0
[325.212940] Dynamic subtest vcs0: SUCCESS (0.046s)
[325.223735] Starting dynamic subtest: vcs1
[325.245059] Dynamic subtest vcs1: SUCCESS (0.029s)
[325.252726] Starting dynamic subtest: vecs0
[325.273992] Dynamic subtest vecs0: SUCCESS (0.028s)
[325.281673] Starting dynamic subtest: ccs0
[325.303885] Dynamic subtest ccs0: SUCCESS (0.029s)
[325.305900] Subtest submit-late-slice: SUCCESS (0.206s)
[326.965833] [045/133] (694s left) gem_mmap_offset (perf)
[327.015630] Starting subtest: perf
[327.017739] Starting dynamic subtest: smem0
[327.353790] Dynamic subtest smem0: SUCCESS (0.337s)
[327.356565] Subtest perf: SUCCESS (0.338s)
[327.462689] [046/133] (693s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[327.524918] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[327.529797] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[327.712216] [047/133] (693s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[327.769872] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[327.851034] [048/133] (693s left) gem_fenced_exec_thrash (2-spare-fences)
[327.912237] Subtest 2-spare-fences: SKIP (0.000s)
[327.982613] [049/133] (693s left) sw_sync (sync_multi_timeline_wait)
[328.025400] Starting subtest: sync_multi_timeline_wait
[328.027774] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[328.098282] [050/133] (693s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[328.203868] Starting subtest: pr-overlay-plane-move-continuous-sf
[328.208068] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[328.268766] [051/133] (693s left) kms_flip (dpms-vs-vblank-race-interruptible)
[328.365123] Starting subtest: dpms-vs-vblank-race-interruptible
[328.367435] Starting dynamic subtest: A-eDP1
[333.284545] Dynamic subtest A-eDP1: SUCCESS (4.918s)
[333.292871] Starting dynamic subtest: B-eDP1
[336.798068] Dynamic subtest B-eDP1: SUCCESS (3.510s)
[336.806744] Starting dynamic subtest: C-eDP1
[341.414586] Dynamic subtest C-eDP1: SUCCESS (4.614s)
[341.423250] Starting dynamic subtest: D-eDP1
[344.936515] Dynamic subtest D-eDP1: SUCCESS (3.521s)
[344.941263] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.575s)
[345.817446] [052/133] (675s left) gem_ccs (block-multicopy-compressed)
[345.892161] Starting subtest: block-multicopy-compressed
[345.896558] Subtest block-multicopy-compressed: SKIP (0.000s)
[346.010956] [053/133] (675s left) perf_pmu (all-busy-idle-check-all)
[346.053240] Starting subtest: all-busy-idle-check-all
[347.926655] Subtest all-busy-idle-check-all: SUCCESS (1.872s)
[348.037554] [054/133] (673s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[348.133223] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[348.137566] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[348.231883] [055/133] (673s left) kms_universal_plane (universal-plane-functional)
[348.323900] Starting subtest: universal-plane-functional
[348.326306] Starting dynamic subtest: pipe-A-eDP-1
[352.398419] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.076s)
[352.408154] Starting dynamic subtest: pipe-B-eDP-1
[356.880332] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.478s)
[356.889249] Starting dynamic subtest: pipe-C-eDP-1
[361.203423] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.323s)
[361.213646] Starting dynamic subtest: pipe-D-eDP-1
[365.527822] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.323s)
[365.530286] Subtest universal-plane-functional: SUCCESS (17.206s)
[366.392145] [056/133] (655s left) sriov_basic (enable-vfs-bind-unbind-each)
[366.464457] Starting subtest: enable-vfs-bind-unbind-each
[366.466319] Starting dynamic subtest: numvfs-1
[366.542945] Dynamic subtest numvfs-1: FAIL (0.013s)
[366.553069] Starting dynamic subtest: numvfs-2
[366.622273] Dynamic subtest numvfs-2: FAIL (0.004s)
[366.631077] Starting dynamic subtest: numvfs-3
[366.705018] Dynamic subtest numvfs-3: FAIL (0.003s)
[366.714350] Starting dynamic subtest: numvfs-4
[366.787731] Dynamic subtest numvfs-4: FAIL (0.004s)
[366.797989] Starting dynamic subtest: numvfs-5
[366.870731] Dynamic subtest numvfs-5: FAIL (0.004s)
[366.883224] Starting dynamic subtest: numvfs-6
[366.956809] Dynamic subtest numvfs-6: FAIL (0.004s)
[366.966499] Starting dynamic subtest: numvfs-7
[367.040215] Dynamic subtest numvfs-7: FAIL (0.003s)
[367.049717] Starting dynamic subtest: numvfs-random
[367.122377] Dynamic subtest numvfs-random: FAIL (0.004s)
[367.124611] Subtest enable-vfs-bind-unbind-each: FAIL (0.044s)
[367.162284] [057/133] (654s left) gen7_exec_parse (cmd-crossing-page)
[367.217324] Subtest cmd-crossing-page: SKIP (0.000s)
[367.283486] [058/133] (654s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[367.374063] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[367.377652] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[367.478452] [059/133] (654s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[367.565268] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[367.567052] Starting dynamic subtest: pipe-A-eDP-1
[367.583826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[367.593319] Starting dynamic subtest: pipe-B-eDP-1
[367.610793] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[367.619664] Starting dynamic subtest: pipe-C-eDP-1
[367.635511] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[367.642779] Starting dynamic subtest: pipe-D-eDP-1
[367.658641] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[367.660194] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.010s)
[369.862157] [060/133] (652s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[369.965502] Starting subtest: fbc-2p-pri-indfb-multidraw
[369.969899] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[370.062770] [061/133] (651s left) i915_query (query-topology-coherent-slice-mask)
[370.128661] Starting subtest: query-topology-coherent-slice-mask
[370.133038] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[370.239376] [062/133] (651s left) kms_async_flips (async-flip-dpms)
[370.337496] Starting subtest: async-flip-dpms
[370.719480] Starting dynamic subtest: pipe-A-eDP-1
[374.494077] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.774s)
[374.875360] Starting dynamic subtest: pipe-B-eDP-1
[377.662081] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.792s)
[378.055605] Starting dynamic subtest: pipe-C-eDP-1
[380.831519] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.785s)
[381.208555] Starting dynamic subtest: pipe-D-eDP-1
[383.997361] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.794s)
[383.999697] Subtest async-flip-dpms: SUCCESS (13.660s)
[385.178644] [063/133] (636s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[385.281016] Starting subtest: fbc-indfb-scaledprimary
[388.246547] Subtest fbc-indfb-scaledprimary: SUCCESS (2.968s)
[389.396183] [064/133] (632s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[389.466041] Subtest tiled-to-untiled: SKIP (0.000s)
[389.547702] [065/133] (632s left) perf_pmu (invalid-init)
[389.591431] Starting subtest: invalid-init
[389.593649] Subtest invalid-init: SUCCESS (0.000s)
[389.695385] [066/133] (632s left) gem_exec_balancer (parallel-contexts)
[389.977930] Starting subtest: parallel-contexts
[392.629601] Subtest parallel-contexts: SUCCESS (2.655s)
[392.750012] [067/133] (629s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[392.874343] Starting subtest: verify-pxp-key-change-after-suspend-resume
[400.128712] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.257s)
[400.261378] [068/133] (621s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[400.363255] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[407.294992] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.932s)
[407.431360] [069/133] (614s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[407.815201] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[408.667224] [070/133] (613s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[408.761197] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[408.763483] Starting dynamic subtest: pipe-A-default-mode
[409.948304] Dynamic subtest pipe-A-default-mode: SKIP (1.184s)
[409.954088] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.185s)
[410.102638] [071/133] (612s left) perf_pmu (interrupts)
[410.141623] Starting subtest: interrupts
[411.231536] Subtest interrupts: SUCCESS (1.089s)
[411.351714] [072/133] (611s left) gem_exec_alignment (forked)
[411.419522] Starting subtest: forked
[450.317408] Subtest forked: SUCCESS (38.893s)
[450.395657] [073/133] (572s left) sysfs_heartbeat_interval (mixed)
[450.500674] Starting subtest: mixed
[450.503044] Starting dynamic subtest: vecs0
[455.748335] Dynamic subtest vecs0: SUCCESS (5.246s)
[455.760310] Starting dynamic subtest: ccs0
[460.931653] Dynamic subtest ccs0: SUCCESS (5.181s)
[460.943937] Starting dynamic subtest: vcs0
[466.152483] Dynamic subtest vcs0: SUCCESS (5.219s)
[466.164246] Starting dynamic subtest: bcs0
[471.344284] Dynamic subtest bcs0: SUCCESS (5.189s)
[471.356104] Starting dynamic subtest: rcs0
[476.509957] Dynamic subtest rcs0: SUCCESS (5.164s)
[476.521159] Starting dynamic subtest: vcs1
[481.747319] Dynamic subtest vcs1: SUCCESS (5.235s)
[481.749826] Subtest mixed: SUCCESS (31.246s)
[481.842861] [074/133] (540s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[481.945097] Starting subtest: fbc-psr2-sprite-mmap-gtt
[481.947314] Starting dynamic subtest: eDP-1
[481.951211] Dynamic subtest eDP-1: SKIP (0.000s)
[481.955192] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[482.016897] [075/133] (540s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[482.112192] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[482.114497] Starting dynamic subtest: pipe-A
[482.136201] Dynamic subtest pipe-A: SKIP (0.020s)
[482.145718] Starting dynamic subtest: pipe-B
[482.169491] Dynamic subtest pipe-B: SKIP (0.034s)
[482.178573] Starting dynamic subtest: pipe-C
[482.199828] Dynamic subtest pipe-C: SKIP (0.029s)
[482.208733] Starting dynamic subtest: pipe-D
[482.228609] Dynamic subtest pipe-D: SKIP (0.029s)
[482.232100] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.114s)
[482.331485] [076/133] (540s left) kms_addfb_basic (size-max)
[482.423695] Starting subtest: size-max
[482.425935] Subtest size-max: SUCCESS (0.000s)
[482.532045] [077/133] (540s left) gem_partial_pwrite_pread (write-uncached)
[482.584651] Subtest write-uncached: SKIP (0.000s)
[482.649988] [078/133] (539s left) kms_joiner (basic-force-big-joiner)
[482.739795] Starting subtest: basic-force-big-joiner
[482.743248] Subtest basic-force-big-joiner: SKIP (0.000s)
[482.808298] [079/133] (539s left) syncobj_timeline (single-wait-all-signaled)
[482.867200] Starting subtest: single-wait-all-signaled
[482.869158] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[482.967444] [080/133] (539s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[483.057121] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[483.058916] Starting dynamic subtest: pipe-A-eDP-1
[483.077191] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[483.088992] Starting dynamic subtest: pipe-B-eDP-1
[483.106180] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[483.115079] Starting dynamic subtest: pipe-C-eDP-1
[483.132419] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[483.141392] Starting dynamic subtest: pipe-D-eDP-1
[483.158503] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[483.161713] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[485.289606] [081/133] (537s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[485.399236] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[486.223917] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[486.372788] [082/133] (536s left) gem_mmap_wc (bad-size)
[486.426294] Subtest bad-size: SKIP (0.000s)
[486.483971] [083/133] (536s left) kms_vblank (wait-forked-hang)
[486.561919] Starting subtest: wait-forked-hang
[486.564146] Starting dynamic subtest: pipe-A-eDP-1
[512.655059] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.089s)
[512.669582] Starting dynamic subtest: pipe-D-eDP-1
[537.693903] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.037s)
[537.696181] Subtest wait-forked-hang: SUCCESS (51.132s)
[538.564192] [084/133] (484s left) gem_fence_thrash (bo-copy)
[538.601927] Starting subtest: bo-copy
[538.626863] Subtest bo-copy: SKIP (0.022s)
[538.684231] [085/133] (484s left) gem_vm_create (invalid-destroy)
[538.730474] Starting subtest: invalid-destroy
[538.732871] Subtest invalid-destroy: SUCCESS (0.002s)
[538.854370] [086/133] (484s left) kms_big_fb (y-tiled-addfb)
[538.946710] Starting subtest: y-tiled-addfb
[538.951093] Subtest y-tiled-addfb: SKIP (0.000s)
[539.041555] [087/133] (483s left) gem_lmem_swapping (heavy-verify-multi)
[539.083737] Subtest heavy-verify-multi: SKIP (0.000s)
[539.126152] [088/133] (483s left) gem_eio (in-flight-suspend)
[539.315407] Starting subtest: in-flight-suspend
[582.302145] Subtest in-flight-suspend: SUCCESS (13.710s)
[582.469398] [089/133] (440s left) sw_sync (sync_merge_invalid)
[582.516585] Starting subtest: sync_merge_invalid
[582.530791] Subtest sync_merge_invalid: SUCCESS (0.016s)
[582.608451] [090/133] (440s left) gem_mmap (bad-offset)
[582.655073] Subtest bad-offset: SKIP (0.000s)
[582.721697] [091/133] (440s left) gem_exec_whisper (basic-normal)
[582.782218] Starting subtest: basic-normal
[588.086517] Subtest basic-normal: SUCCESS (5.487s)
[588.272103] [092/133] (434s left) gem_sync (basic-all)
[588.341950] Starting subtest: basic-all
[592.111732] Subtest basic-all: SUCCESS (3.845s)
[592.293634] [093/133] (430s left) i915_query (query-topology-unsupported)
[592.354733] Starting subtest: query-topology-unsupported
[592.359144] Subtest query-topology-unsupported: SKIP (0.000s)
[592.460279] [094/133] (430s left) kms_psr (psr-sprite-plane-move)
[592.571187] Starting subtest: psr-sprite-plane-move
[592.573379] Starting dynamic subtest: eDP-1
[594.383916] Dynamic subtest eDP-1: SUCCESS (1.834s)
[594.386293] Subtest psr-sprite-plane-move: SUCCESS (1.836s)
[595.189428] [095/133] (428s left) kms_atomic (plane-immutable-zpos)
[595.282770] Starting subtest: plane-immutable-zpos
[595.285095] Starting dynamic subtest: pipe-A-eDP-1
[595.914725] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[595.916589] Subtest plane-immutable-zpos: SUCCESS (0.635s)
[596.717367] [096/133] (426s left) kms_addfb_basic (bad-pitch-1024)
[596.776697] Starting subtest: bad-pitch-1024
[596.778519] Subtest bad-pitch-1024: SUCCESS (0.000s)
[596.911544] [097/133] (426s left) syncobj_eventfd (binary-wait-before-signal)
[596.972511] Starting subtest: binary-wait-before-signal
[597.004211] Subtest binary-wait-before-signal: SUCCESS (0.032s)
[597.083305] [098/133] (426s left) kms_cursor_edge_walk (256x256-top-edge)
[597.172499] Starting subtest: 256x256-top-edge
[597.174886] Starting dynamic subtest: pipe-A-eDP-1
[600.649173] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s)
[600.661562] Starting dynamic subtest: pipe-D-eDP-1
[603.787449] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.151s)
[603.789733] Subtest 256x256-top-edge: SUCCESS (6.653s)
[604.600445] [099/133] (418s left) kms_psr (pr-suspend)
[604.701037] Starting subtest: pr-suspend
[604.705550] Subtest pr-suspend: SKIP (0.000s)
[604.773556] [100/133] (418s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[604.840167] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[604.948677] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[605.039496] [101/133] (418s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[605.146962] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[609.438167] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.304s)
[610.576434] [102/133] (413s left) gem_ctx_isolation (nonpriv)
[610.642401] Starting subtest: nonpriv
[610.644938] Starting dynamic subtest: rcs0
[610.867386] Dynamic subtest rcs0: SUCCESS (0.225s)
[610.877222] Starting dynamic subtest: bcs0
[611.117885] Dynamic subtest bcs0: SUCCESS (0.250s)
[611.127603] Starting dynamic subtest: vcs0
[611.369055] Dynamic subtest vcs0: SUCCESS (0.251s)
[611.378566] Starting dynamic subtest: vcs1
[613.408127] Dynamic subtest vcs1: SUCCESS (2.039s)
[613.420586] Starting dynamic subtest: vecs0
[615.391880] Dynamic subtest vecs0: SUCCESS (1.981s)
[615.403570] Starting dynamic subtest: ccs0
[617.457605] Dynamic subtest ccs0: SUCCESS (2.064s)
[617.459901] Subtest nonpriv: SUCCESS (6.816s)
[617.710365] [103/133] (405s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[617.833905] Starting subtest: 2x-flip-vs-cursor-legacy
[617.838259] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[617.981904] [104/133] (405s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[618.104790] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[618.109377] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[618.202161] [105/133] (405s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[618.299977] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[625.243636] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.944s)
[625.359396] [106/133] (398s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[625.413448] Starting subtest: invalid-single-wait-unsubmitted
[625.415744] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[625.513399] [107/133] (398s left) api_intel_bb (object-noreloc-purge-cache-simple)
[625.558454] Starting subtest: object-noreloc-purge-cache-simple
[625.562415] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s)
[625.684398] [108/133] (398s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[625.778770] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[625.783108] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[625.893798] [109/133] (397s left) kms_content_protection (legacy-hdcp14)
[626.024571] Starting subtest: legacy-hdcp14
[626.029148] Subtest legacy-hdcp14: SKIP (0.000s)
[626.150975] [110/133] (397s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[626.237173] Starting subtest: psr2-cursor-plane-update-sf
[626.239100] Starting dynamic subtest: pipe-A-eDP-1
[626.809086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[626.824916] Starting dynamic subtest: pipe-B-eDP-1
[628.097314] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s)
[628.099680] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.864s)
[628.961390] [111/133] (395s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[629.083632] Starting subtest: short-busy-flip-before-cursor-toggle
[629.088144] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[629.227789] [112/133] (394s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[629.326925] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[629.331331] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[629.416029] [113/133] (394s left) gen9_exec_parse (unaligned-access)
[629.472876] Subtest unaligned-access: SKIP (0.000s)
[629.546923] [114/133] (394s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[629.647632] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[629.651856] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[629.740456] [115/133] (394s left) kms_vrr (flip-suspend)
[629.842725] Starting subtest: flip-suspend
[629.848247] Subtest flip-suspend: SKIP (0.000s)
[629.928289] [116/133] (394s left) drm_read (short-buffer-block)
[630.073610] Starting subtest: short-buffer-block
[630.075545] Subtest short-buffer-block: SUCCESS (0.000s)
[630.193444] [117/133] (394s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[630.298094] Starting subtest: read-crc-frame-sequence
[630.299975] Starting dynamic subtest: pipe-A-eDP-1
[631.021910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[631.032968] Starting dynamic subtest: pipe-B-eDP-1
[632.429731] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.407s)
[632.441035] Starting dynamic subtest: pipe-C-eDP-1
[633.728624] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.298s)
[633.738255] Starting dynamic subtest: pipe-D-eDP-1
[635.048560] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[635.050946] Subtest read-crc-frame-sequence: SUCCESS (4.750s)
[635.881329] [118/133] (388s left) perf_pmu (most-busy-idle-check-all)
[635.928034] Starting subtest: most-busy-idle-check-all
[635.929952] Starting dynamic subtest: rcs0
[637.168090] Dynamic subtest rcs0: SUCCESS (1.239s)
[637.180295] Starting dynamic subtest: bcs0
[639.216708] Dynamic subtest bcs0: SUCCESS (2.047s)
[639.229261] Starting dynamic subtest: vcs0
[641.201051] Dynamic subtest vcs0: SUCCESS (1.982s)
[641.214036] Starting dynamic subtest: vcs1
[643.184999] Dynamic subtest vcs1: SUCCESS (1.981s)
[643.198458] Starting dynamic subtest: vecs0
[645.169074] Dynamic subtest vecs0: SUCCESS (1.981s)
[645.181981] Starting dynamic subtest: ccs0
[647.152799] Dynamic subtest ccs0: SUCCESS (1.981s)
[647.155574] Subtest most-busy-idle-check-all: SUCCESS (11.229s)
[647.258816] [119/133] (377s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[647.361514] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[647.363362] Starting dynamic subtest: pipe-A-eDP-1
[647.383071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[647.398409] Starting dynamic subtest: pipe-B-eDP-1
[647.417824] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[647.428222] Starting dynamic subtest: pipe-C-eDP-1
[647.447391] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[647.457246] Starting dynamic subtest: pipe-D-eDP-1
[647.477738] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[647.479976] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.084s)
[649.662089] [120/133] (374s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[649.766991] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[649.770880] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[649.871245] [121/133] (374s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[649.962905] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[649.966892] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[650.037024] [122/133] (374s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[650.130915] Starting subtest: psr-rgb101010-draw-blt
[657.373348] Subtest psr-rgb101010-draw-blt: SUCCESS (7.247s)
[657.508906] [123/133] (366s left) gem_exec_flush (basic-wb-prw-default)
[657.560606] Starting subtest: basic-wb-prw-default
[663.034690] Subtest basic-wb-prw-default: SUCCESS (5.476s)
[663.224618] [124/133] (361s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[663.291829] Starting subtest: multi-wait-all-for-submit-signaled
[663.294210] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[663.387649] [125/133] (361s left) i915_hangman (hangcheck-unterminated)
[663.454070] Starting subtest: hangcheck-unterminated
[675.150868] Subtest hangcheck-unterminated: SUCCESS (11.700s)
[675.277195] [126/133] (349s left) gem_exec_balancer (full-late)
[675.346176] Starting subtest: full-late
[680.080210] Subtest full-late: SUCCESS (4.733s)
[680.391726] [127/133] (344s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[680.495663] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[687.064682] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.570s)
[687.215177] [128/133] (337s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[687.484694] Starting subtest: cursor-rapid-movement-256x85
[687.532681] Subtest cursor-rapid-movement-256x85: SKIP (0.041s)
[687.717520] [129/133] (337s left) syncobj_timeline (etime-single-wait-submitted)
[687.766742] Starting subtest: etime-single-wait-submitted
[687.867187] Subtest etime-single-wait-submitted: SUCCESS (0.102s)
[687.946367] [130/133] (336s left) gem_userptr_blits (coherency-sync)
[688.016749] Starting subtest: coherency-sync
[688.187185] Subtest coherency-sync: SKIP (0.132s)
[688.291808] [131/133] (336s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[688.449565] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[688.453621] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[688.558053] [132/133] (336s left) gem_exec_schedule (implicit-boths)
[688.659282] Starting subtest: implicit-boths
[688.661220] Starting dynamic subtest: rcs0
[688.763743] Dynamic subtest rcs0: SUCCESS (0.113s)
[688.776218] Starting dynamic subtest: vcs0
[688.858155] Dynamic subtest vcs0: SUCCESS (0.093s)
[688.870678] Starting dynamic subtest: vcs1
[688.935730] Dynamic subtest vcs1: SUCCESS (0.076s)
[688.947550] Starting dynamic subtest: vecs0
[689.021649] Dynamic subtest vecs0: SUCCESS (0.086s)
[689.032697] Starting dynamic subtest: ccs0
[689.124039] Dynamic subtest ccs0: SUCCESS (0.102s)
[689.126433] Subtest implicit-boths: SUCCESS (0.475s)
[690.252948] [133/133] (334s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[690.352849] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[690.357234] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[690.446277] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: kms_chamelium_frames
results: parsing output: 2/ for test: gem_ctx_persistence
results: parsing output: 3/ for test: api_intel_allocator
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: sw_sync
results: parsing output: 8/ for test: i915_suspend
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_userptr_blits
results: parsing output: 11/ for test: gem_exec_capture
results: parsing output: 12/ for test: kms_dsc
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: gem_cs_tlb
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_panel_fitting
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: gem_caching
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: dmabuf_sync_file
results: parsing output: 25/ for test: kms_color
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: i915_pm_rc6_residency
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_plane_lowres
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_plane
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: gem_mmap_offset
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: gem_fenced_exec_thrash
results: parsing output: 48/ for test: sw_sync
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gem_ccs
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_universal_plane
results: parsing output: 55/ for test: sriov_basic
results: parsing output: 56/ for test: gen7_exec_parse
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: i915_query
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_set_tiling_vs_blt
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: gem_pxp
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: gem_exec_alignment
results: parsing output: 72/ for test: sysfs_heartbeat_interval
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: gem_partial_pwrite_pread
results: parsing output: 77/ for test: kms_joiner
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: gem_fence_thrash
results: parsing output: 84/ for test: gem_vm_create
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: sw_sync
results: parsing output: 89/ for test: gem_mmap
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: gem_sync
results: parsing output: 92/ for test: i915_query
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_atomic
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: syncobj_eventfd
results: parsing output: 97/ for test: kms_cursor_edge_walk
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_ctx_isolation
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: api_intel_bb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_vrr
results: parsing output: 115/ for test: drm_read
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: i915_hangman
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_exec_schedule
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.