[59.184757] Initializing watchdogs
[59.184818]   /dev/watchdog0
[59.198054] [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.201891] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.204185] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.207704] [001/131] (960s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[59.352191] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[59.356800] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[59.528431] [002/131] (960s left) kms_addfb_basic (invalid-get-prop-any)
[59.587619] Starting subtest: invalid-get-prop-any
[59.590047] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[59.715583] [003/131] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[59.825175] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[60.834637] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.998s)
[60.965745] [004/131] (958s left) gem_exec_reloc (basic-cpu-gtt-active)
[61.037328] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[61.106313] [005/131] (958s left) gem_softpin (noreloc)
[61.171130] Starting subtest: noreloc
[66.619014] Subtest noreloc: SUCCESS (5.403s)
[66.724580] [006/131] (953s left) kms_flip (2x-wf_vblank-ts-check)
[66.832381] Starting subtest: 2x-wf_vblank-ts-check
[66.843504] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[66.948838] [007/131] (953s left) gem_blits (basic)
[67.004316] Starting subtest: basic
[68.238596] Subtest basic: SUCCESS (1.227s)
[68.371032] [008/131] (951s left) kms_dirtyfb (default-dirtyfb-ioctl)
[68.484162] Starting subtest: default-dirtyfb-ioctl
[68.486480] Starting dynamic subtest: A-eDP-1
[70.112759] Dynamic subtest A-eDP-1: SUCCESS (1.620s)
[70.115219] Subtest default-dirtyfb-ioctl: SUCCESS (1.620s)
[70.977610] [009/131] (949s left) gem_exec_params (sol-reset-not-gen7)
[71.061809] Starting subtest: sol-reset-not-gen7
[71.067222] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[71.330705] [010/131] (948s left) drm_mm (drm_mm)
[71.380255] Starting subtest: drm_mm
[71.450937] Starting dynamic subtest: drm_test_mm_init
[71.791858] Dynamic subtest drm_test_mm_init: SUCCESS (0.340s)
[71.801195] Starting dynamic subtest: drm_test_mm_debug
[72.129714] Dynamic subtest drm_test_mm_debug: SUCCESS (0.337s)
[72.138964] Starting dynamic subtest: drm_test_mm_align32
[72.269347] Dynamic subtest drm_test_mm_align32: SUCCESS (0.139s)
[72.278020] Starting dynamic subtest: drm_test_mm_align64
[72.392586] Dynamic subtest drm_test_mm_align64: SUCCESS (0.123s)
[72.401308] Starting dynamic subtest: drm_test_mm_lowest
[72.487468] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.094s)
[72.496167] Starting dynamic subtest: drm_test_mm_highest
[72.650506] Dynamic subtest drm_test_mm_highest: SUCCESS (0.162s)
[72.652912] Subtest drm_mm: SUCCESS (1.266s)
[72.805875] [011/131] (947s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[72.931598] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[81.232349] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.290s)
[82.024479] [012/131] (938s left) gem_exec_reloc (basic-wc)
[82.080474] Subtest basic-wc: SKIP (0.000s)
[82.126584] [013/131] (938s left) gem_exec_schedule (pi-userfault)
[82.309026] Starting subtest: pi-userfault
[82.311302] Starting dynamic subtest: rcs0
[82.316571] Dynamic subtest rcs0: SUCCESS (0.010s)
[82.323871] Starting dynamic subtest: bcs0
[82.325927] Dynamic subtest bcs0: SUCCESS (0.006s)
[82.332712] Starting dynamic subtest: vcs0
[82.334956] Dynamic subtest vcs0: SUCCESS (0.008s)
[82.341459] Starting dynamic subtest: vcs1
[82.343388] Dynamic subtest vcs1: SUCCESS (0.007s)
[82.350381] Starting dynamic subtest: vecs0
[82.352657] Dynamic subtest vecs0: SUCCESS (0.006s)
[82.359263] Starting dynamic subtest: ccs0
[82.361514] Dynamic subtest ccs0: SUCCESS (0.006s)
[82.363781] Subtest pi-userfault: SUCCESS (0.044s)
[82.527626] [014/131] (937s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[82.628435] Starting subtest: y-tiled-32bpp-rotate-90
[82.632613] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[82.733152] [015/131] (937s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[82.830050] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[82.832876] Starting dynamic subtest: pipe-A-default-mode
[83.121497] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[83.126426] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.286s)
[83.947578] [016/131] (936s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[84.051036] Starting subtest: fbc-psr2-cursor-mmap-gtt
[84.053069] Starting dynamic subtest: eDP-1
[84.057255] Dynamic subtest eDP-1: SKIP (0.000s)
[84.061528] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[84.111223] [017/131] (936s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[84.184338] Subtest writes-after-reads: SKIP (0.000s)
[84.260150] [018/131] (936s left) dmabuf (all-tests)
[84.296214] Starting subtest: all-tests
[84.298288] Starting dynamic subtest: sanitycheck
[84.435625] Dynamic subtest sanitycheck: SUCCESS (0.139s)
[84.446200] Starting dynamic subtest: dma_fence
[84.731757] Dynamic subtest dma_fence: SUCCESS (0.295s)
[84.741476] Starting dynamic subtest: dma_fence_chain
[93.409456] Dynamic subtest dma_fence_chain: SUCCESS (8.674s)
[93.419084] Starting dynamic subtest: dma_fence_unwrap
[93.515257] Dynamic subtest dma_fence_unwrap: SUCCESS (0.106s)
[93.524251] Starting dynamic subtest: dma_resv
[93.632637] Dynamic subtest dma_resv: SUCCESS (0.116s)
[93.635287] Subtest all-tests: SUCCESS (9.332s)
[93.689168] [019/131] (926s left) kms_fence_pin_leak
[93.859745] [020/131] (926s left) gem_exec_store (cachelines)
[93.930655] Starting subtest: cachelines
[93.933114] Starting dynamic subtest: rcs0
[94.049956] Dynamic subtest rcs0: SUCCESS (0.120s)
[94.059630] Starting dynamic subtest: bcs0
[94.100243] Dynamic subtest bcs0: SUCCESS (0.050s)
[94.113296] Starting dynamic subtest: vcs0
[94.163142] Dynamic subtest vcs0: SUCCESS (0.062s)
[94.172533] Starting dynamic subtest: vcs1
[94.227796] Dynamic subtest vcs1: SUCCESS (0.065s)
[94.237178] Starting dynamic subtest: vecs0
[94.294242] Dynamic subtest vecs0: SUCCESS (0.066s)
[94.302988] Starting dynamic subtest: ccs0
[94.361219] Dynamic subtest ccs0: SUCCESS (0.067s)
[94.363678] Subtest cachelines: SUCCESS (0.432s)
[94.541760] [021/131] (925s left) gem_create (create-ext-cpu-access-sanity-check)
[94.710282] Starting subtest: create-ext-cpu-access-sanity-check
[94.715693] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[94.776352] [022/131] (925s left) gem_pxp (hw-rejects-pxp-context)
[94.912450] Starting subtest: hw-rejects-pxp-context
[94.916867] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[95.031384] [023/131] (925s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[95.151028] Starting subtest: fbc-rgb565-draw-pwrite
[98.852890] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.705s)
[98.975408] [024/131] (921s left) kms_chamelium_hpd (hdmi-hpd)
[99.359142] Subtest hdmi-hpd: SKIP (0.000s)
[100.186838] [025/131] (920s left) gem_ctx_isolation (preservation-reset)
[100.356151] Starting subtest: preservation-reset
[100.358368] Starting dynamic subtest: rcs0
[100.750384] Dynamic subtest rcs0: SUCCESS (0.395s)
[100.757796] Starting dynamic subtest: bcs0
[101.227440] Dynamic subtest bcs0: SUCCESS (0.476s)
[101.240172] Starting dynamic subtest: vcs0
[101.722734] Dynamic subtest vcs0: SUCCESS (0.495s)
[101.732071] Starting dynamic subtest: vcs1
[103.406328] Dynamic subtest vcs1: SUCCESS (1.683s)
[103.414230] Starting dynamic subtest: vecs0
[105.343070] Dynamic subtest vecs0: SUCCESS (1.937s)
[105.350733] Starting dynamic subtest: ccs0
[107.368070] Dynamic subtest ccs0: SUCCESS (2.024s)
[107.371059] Subtest preservation-reset: SUCCESS (7.012s)
[107.580189] [026/131] (913s left) gem_exec_fence (syncobj-invalid-wait)
[108.051439] Starting subtest: syncobj-invalid-wait
[108.053797] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[109.983554] [FACT gem_exec_fence (syncobj-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[109.987587] [027/131] (910s left) kms_psr (psr-suspend)
[110.085165] Starting subtest: psr-suspend
[110.087609] Starting dynamic subtest: eDP-1
[127.385024] Dynamic subtest eDP-1: SUCCESS (2.983s)
[127.387675] Subtest psr-suspend: SUCCESS (2.984s)
[128.276586] [028/131] (906s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[128.682271] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[129.540661] [029/131] (905s left) kms_pm_rpm (pm-tiling)
[131.413295] Starting subtest: pm-tiling
[131.419005] Subtest pm-tiling: SKIP (0.000s)
[131.861807] [030/131] (903s left) gem_lmem_swapping (parallel-random-verify-ccs)
[131.908152] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[131.946317] [031/131] (903s left) kms_psr (pr-no-drrs)
[132.046563] Starting subtest: pr-no-drrs
[132.051343] Subtest pr-no-drrs: SKIP (0.000s)
[132.114535] [032/131] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[132.216420] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[132.220772] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[132.318572] [033/131] (903s left) gem_pread (uncached)
[132.372778] Subtest uncached: SKIP (0.000s)
[132.429015] [034/131] (902s left) gem_userptr_blits (input-checking)
[132.497819] Starting subtest: input-checking
[132.500080] Subtest input-checking: SUCCESS (0.000s)
[132.635670] [035/131] (902s left) sysfs_heartbeat_interval (precise)
[132.701607] Starting subtest: precise
[132.704046] Starting dynamic subtest: vecs0
[140.251561] Dynamic subtest vecs0: SUCCESS (7.441s)
[140.261451] Starting dynamic subtest: ccs0
[141.341257] Dynamic subtest ccs0: SUCCESS (1.083s)
[141.351848] Starting dynamic subtest: vcs0
[149.215575] Dynamic subtest vcs0: SUCCESS (7.837s)
[149.225277] Starting dynamic subtest: bcs0
[150.407145] Dynamic subtest bcs0: SUCCESS (1.187s)
[150.420391] Starting dynamic subtest: rcs0
[153.216223] Dynamic subtest rcs0: SUCCESS (2.800s)
[153.227071] Starting dynamic subtest: vcs1
[161.203030] Dynamic subtest vcs1: SUCCESS (7.989s)
[161.205680] Subtest precise: SUCCESS (28.340s)
[161.276810] [036/131] (874s left) kms_lease (page-flip-implicit-plane)
[161.381628] Starting subtest: page-flip-implicit-plane
[161.384017] Starting dynamic subtest: pipe-A-eDP-1
[161.980247] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[161.990563] Starting dynamic subtest: pipe-B-eDP-1
[163.062631] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.085s)
[163.073848] Starting dynamic subtest: pipe-C-eDP-1
[164.175015] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[164.184071] Starting dynamic subtest: pipe-D-eDP-1
[165.304428] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[165.307019] Subtest page-flip-implicit-plane: SUCCESS (3.926s)
[166.133919] [037/131] (869s left) gem_mmap_gtt (basic-short)
[166.206282] Subtest basic-short: SKIP (0.000s)
[166.266200] [038/131] (869s left) kms_color (ctm-negative)
[166.369672] Starting subtest: ctm-negative
[166.372018] Starting dynamic subtest: pipe-A-eDP-1
[167.055489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[167.064001] Starting dynamic subtest: pipe-B-eDP-1
[168.507761] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.452s)
[168.517819] Starting dynamic subtest: pipe-C-eDP-1
[169.870841] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s)
[169.880221] Starting dynamic subtest: pipe-D-eDP-1
[171.339963] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.469s)
[171.342321] Subtest ctm-negative: SUCCESS (4.972s)
[172.121536] [039/131] (863s left) api_intel_bb (destroy-bb)
[172.185884] Starting subtest: destroy-bb
[172.192022] Subtest destroy-bb: SUCCESS (0.009s)
[172.328191] [040/131] (863s left) perf_pmu (frequency)
[172.369627] Starting subtest: frequency
[172.372072] Starting dynamic subtest: gt0
[174.557448] Dynamic subtest gt0: SUCCESS (2.183s)
[174.566202] Starting dynamic subtest: idle-gt0
[175.062031] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[175.072505] Starting dynamic subtest: gt1
[179.221535] Dynamic subtest gt1: SUCCESS (4.151s)
[179.230386] Starting dynamic subtest: idle-gt1
[179.747846] Dynamic subtest idle-gt1: SUCCESS (0.535s)
[179.750662] Subtest frequency: SUCCESS (7.383s)
[179.848496] [041/131] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[179.956262] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[179.960856] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[180.055460] [042/131] (855s left) perf_pmu (init-wait)
[180.096024] Starting subtest: init-wait
[180.098441] Starting dynamic subtest: rcs0
[180.100813] Dynamic subtest rcs0: SUCCESS (0.001s)
[180.111467] Starting dynamic subtest: bcs0
[180.113696] Dynamic subtest bcs0: SUCCESS (0.000s)
[180.124091] Starting dynamic subtest: vcs0
[180.126283] Dynamic subtest vcs0: SUCCESS (0.001s)
[180.134659] Starting dynamic subtest: vcs1
[180.136856] Dynamic subtest vcs1: SUCCESS (0.001s)
[180.145147] Starting dynamic subtest: vecs0
[180.147408] Dynamic subtest vecs0: SUCCESS (0.001s)
[180.157495] Starting dynamic subtest: ccs0
[180.159876] Dynamic subtest ccs0: SUCCESS (0.000s)
[180.162058] Subtest init-wait: SUCCESS (0.005s)
[180.209748] [043/131] (855s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[180.305143] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[180.309877] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[180.409718] [044/131] (855s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[180.464317] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[180.570812] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s)
[180.643480] [045/131] (855s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[180.757774] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[180.762452] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[180.859081] [046/131] (855s left) i915_pm_rpm (debugfs-read)
[182.395984] Starting subtest: debugfs-read
[183.556226] Subtest debugfs-read: SUCCESS (1.157s)
[183.900015] [047/131] (852s left) kms_universal_plane (universal-plane-functional)
[184.004539] Starting subtest: universal-plane-functional
[184.006886] Starting dynamic subtest: pipe-A-eDP-1
[187.840297] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.834s)
[187.854981] Starting dynamic subtest: pipe-B-eDP-1
[192.296125] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.454s)
[192.304836] Starting dynamic subtest: pipe-C-eDP-1
[196.542120] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.245s)
[196.551882] Starting dynamic subtest: pipe-D-eDP-1
[200.737296] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.193s)
[200.739681] Subtest universal-plane-functional: SUCCESS (16.731s)
[201.516915] [048/131] (834s left) gem_exec_params (larger-than-life-batch)
[201.580508] Starting subtest: larger-than-life-batch
[205.160562] Subtest larger-than-life-batch: SUCCESS (3.579s)
[206.282655] [049/131] (829s left) kms_big_fb (linear-16bpp-rotate-270)
[206.443550] Starting subtest: linear-16bpp-rotate-270
[206.462215] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[206.588254] [050/131] (829s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[206.691135] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[211.963305] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.275s)
[212.131339] [051/131] (824s left) sw_sync (sync_random_merge)
[212.180076] Starting subtest: sync_random_merge
[212.220438] Subtest sync_random_merge: SUCCESS (0.041s)
[212.276924] [052/131] (823s left) vgem_basic (dmabuf-mmap)
[212.324401] Starting subtest: dmabuf-mmap
[212.369011] Subtest dmabuf-mmap: SUCCESS (0.046s)
[212.437387] [053/131] (823s left) kms_frontbuffer_tracking (fbc-tiling-y)
[212.538043] Starting subtest: fbc-tiling-y
[212.542011] Subtest fbc-tiling-y: SKIP (0.000s)
[212.646434] [054/131] (823s left) kms_psr (psr-primary-mmap-gtt)
[212.740812] Starting subtest: psr-primary-mmap-gtt
[212.743064] Starting dynamic subtest: eDP-1
[214.173443] Dynamic subtest eDP-1: SKIP (1.427s)
[214.178398] Subtest psr-primary-mmap-gtt: SKIP (1.428s)
[214.315188] [055/131] (822s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[219.369509] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[219.374542] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.003s)
[220.205677] [056/131] (816s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[220.311357] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[220.313654] Starting dynamic subtest: pipe-A-default-mode
[220.599170] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[220.603900] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.284s)
[221.427479] [057/131] (814s left) kms_plane (plane-panning-bottom-right)
[221.526720] Starting subtest: plane-panning-bottom-right
[221.529124] Starting dynamic subtest: pipe-A
[223.168073] Dynamic subtest pipe-A: SUCCESS (1.636s)
[223.178342] Starting dynamic subtest: pipe-B
[225.410458] Dynamic subtest pipe-B: SUCCESS (2.245s)
[225.412975] Subtest plane-panning-bottom-right: SUCCESS (3.883s)
[226.216471] [058/131] (810s left) gem_exec_flush (basic-wb-ro-default)
[226.282108] Starting subtest: basic-wb-ro-default
[231.762142] Subtest basic-wb-ro-default: SUCCESS (5.479s)
[231.948181] [059/131] (804s left) gem_softpin (noreloc-s3)
[232.018129] Starting subtest: noreloc-S3
[252.233481] Subtest noreloc-S3: SUCCESS (5.417s)
[252.381945] [060/131] (798s left) kms_joiner (basic-max-non-joiner)
[252.503662] Starting subtest: basic-max-non-joiner
[252.507939] Subtest basic-max-non-joiner: SKIP (0.000s)
[252.565855] [061/131] (798s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[252.664974] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[252.667471] Starting dynamic subtest: pipe-A-eDP-1
[252.692567] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[252.704621] Starting dynamic subtest: pipe-B-eDP-1
[252.727532] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[252.736925] Starting dynamic subtest: pipe-C-eDP-1
[252.758813] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[252.767345] Starting dynamic subtest: pipe-D-eDP-1
[252.788947] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[252.792954] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[254.849749] [062/131] (796s left) kms_pm_dc (dc9-dpms)
[255.951743] Starting subtest: dc9-dpms
[257.354230] Subtest dc9-dpms: SUCCESS (1.385s)
[257.425373] [063/131] (794s left) syncobj_timeline (invalid-transfer-bad-pad)
[257.489276] Starting subtest: invalid-transfer-bad-pad
[257.491494] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[257.569977] [064/131] (793s left) gem_exec_fence (basic-busy-all)
[257.642989] Starting subtest: basic-busy-all
[257.750312] Subtest basic-busy-all: SUCCESS (0.107s)
[260.042794] [065/131] (791s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[260.102383] Subtest no-spare-fences-busy: SKIP (0.000s)
[260.162940] [066/131] (791s left) kms_content_protection (mei-interface)
[260.347187] Starting subtest: mei-interface
[260.351799] Subtest mei-interface: SKIP (0.001s)
[260.499943] [067/131] (791s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[260.556706] Starting subtest: invalid-bsd2-flag-on-blt
[260.559176] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[260.674013] [068/131] (791s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[260.773734] Starting subtest: primary-x-tiled-reflect-x-180
[267.723927] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.912s)
[268.918642] [069/131] (782s left) gem_mmap_offset (basic-uaf)
[268.972789] Starting subtest: basic-uaf
[268.975179] Subtest basic-uaf: SUCCESS (0.002s)
[269.069454] [070/131] (782s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[269.137895] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[269.142456] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[269.324831] [071/131] (782s left) gem_mmap_gtt (fault-concurrent-y)
[269.384488] Subtest fault-concurrent-Y: SKIP (0.000s)
[269.445809] [072/131] (782s left) gen9_exec_parse (bb-start-cmd)
[269.505064] Subtest bb-start-cmd: SKIP (0.000s)
[269.575372] [073/131] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[269.678330] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[274.899617] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (5.211s)
[275.064101] [074/131] (776s left) i915_pm_rps (reset)
[275.137739] Starting subtest: reset
[275.223840] Subtest reset: FAIL (0.026s)
[275.298801] [075/131] (776s left) kms_cursor_crc (cursor-onscreen-512x512)
[275.549345] Starting subtest: cursor-onscreen-512x512
[275.553906] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[275.706115] [076/131] (776s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[275.831970] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[275.834345] Starting dynamic subtest: pipe-A-default-mode
[276.134444] Dynamic subtest pipe-A-default-mode: SKIP (0.297s)
[276.139070] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.298s)
[276.905748] [077/131] (775s left) gem_ctx_persistence (legacy-engines-cleanup)
[276.974993] Starting subtest: legacy-engines-cleanup
[276.977299] Starting dynamic subtest: render
[277.062618] Dynamic subtest render: SUCCESS (0.086s)
[277.074944] Starting dynamic subtest: bsd1
[277.117232] Dynamic subtest bsd1: SUCCESS (0.053s)
[277.128703] Starting dynamic subtest: bsd2
[277.165744] Dynamic subtest bsd2: SUCCESS (0.046s)
[277.177299] Starting dynamic subtest: blt
[277.183392] Dynamic subtest blt: SUCCESS (0.016s)
[277.192224] Starting dynamic subtest: vebox
[277.277111] Dynamic subtest vebox: SUCCESS (0.093s)
[277.279827] Subtest legacy-engines-cleanup: SUCCESS (0.302s)
[277.353834] [078/131] (774s left) kms_psr (fbc-psr2-primary-page-flip)
[277.450656] Starting subtest: fbc-psr2-primary-page-flip
[277.453038] Starting dynamic subtest: eDP-1
[277.457466] Dynamic subtest eDP-1: SKIP (0.000s)
[277.461861] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[277.518258] [079/131] (774s left) gem_eio (create)
[277.755689] Starting subtest: create
[278.106904] Subtest create: SUCCESS (0.351s)
[278.237773] [080/131] (773s left) gem_exec_fence (concurrent)
[278.408832] Starting subtest: concurrent
[278.413370] Subtest concurrent: SKIP (0.000s)
[280.018936] [081/131] (772s left) syncobj_timeline (single-wait-all-signaled)
[280.073289] Starting subtest: single-wait-all-signaled
[280.075593] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[280.177458] [082/131] (772s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[285.154350] Starting subtest: pr-plane-move-sf-dmg-area
[285.159039] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s)
[286.003772] [083/131] (766s left) kms_psr (pr-suspend)
[286.107825] Starting subtest: pr-suspend
[286.112132] Subtest pr-suspend: SKIP (0.000s)
[286.174025] [084/131] (766s left) gen3_render_mixed_blits
[286.292460] [085/131] (766s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[286.349572] Starting subtest: etime-single-wait-all-available-unsubmitted
[286.457997] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.106s)
[286.543168] [086/131] (765s left) kms_atomic (plane-primary-legacy)
[286.646529] Starting subtest: plane-primary-legacy
[286.648925] Starting dynamic subtest: pipe-A-eDP-1
[287.125596] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.477s)
[287.127927] Subtest plane-primary-legacy: SUCCESS (0.478s)
[287.935075] [087/131] (764s left) syncobj_eventfd (invalid-bad-flags)
[288.000446] Starting subtest: invalid-bad-flags
[288.002859] Subtest invalid-bad-flags: SUCCESS (0.000s)
[288.112930] [088/131] (764s left) kms_cdclk (plane-scaling)
[288.217674] Starting subtest: plane-scaling
[288.219933] Starting dynamic subtest: pipe-A-eDP-1
[288.507421] Dynamic subtest pipe-A-eDP-1: SKIP (0.284s)
[288.517936] Starting dynamic subtest: pipe-B-eDP-1
[288.522474] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[288.531716] Starting dynamic subtest: pipe-C-eDP-1
[288.536151] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[288.545100] Starting dynamic subtest: pipe-D-eDP-1
[288.549668] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[288.554085] Subtest plane-scaling: SKIP (0.291s)
[289.360767] [089/131] (763s left) kms_plane_cursor (overlay)
[289.460700] Starting subtest: overlay
[289.465171] Starting dynamic subtest: pipe-A-eDP-1-size-64
[292.311184] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.849s)
[292.373910] Starting dynamic subtest: pipe-A-eDP-1-size-128
[295.246268] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.881s)
[295.308709] Starting dynamic subtest: pipe-A-eDP-1-size-256
[298.138131] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.837s)
[298.489039] Starting dynamic subtest: pipe-B-eDP-1-size-64
[302.079318] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.600s)
[302.139373] Starting dynamic subtest: pipe-B-eDP-1-size-128
[305.025341] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.893s)
[305.086328] Starting dynamic subtest: pipe-B-eDP-1-size-256
[307.994818] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.915s)
[308.343986] Starting dynamic subtest: pipe-C-eDP-1-size-64
[311.512224] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.178s)
[311.549613] Starting dynamic subtest: pipe-C-eDP-1-size-128
[313.990833] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.446s)
[314.030641] Starting dynamic subtest: pipe-C-eDP-1-size-256
[316.504318] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.480s)
[316.831372] Starting dynamic subtest: pipe-D-eDP-1-size-64
[320.010934] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.188s)
[320.049464] Starting dynamic subtest: pipe-D-eDP-1-size-128
[322.500756] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.457s)
[322.539939] Starting dynamic subtest: pipe-D-eDP-1-size-256
[325.034589] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.502s)
[325.351689] Subtest overlay: SUCCESS (35.877s)
[326.173281] [090/131] (726s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[326.284135] Starting subtest: yf-tiled-64bpp-rotate-0
[326.288722] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[326.397215] [091/131] (726s left) gem_exec_whisper (basic-fds-forked-all)
[326.469765] Starting subtest: basic-fds-forked-all
[347.986165] Subtest basic-fds-forked-all: SUCCESS (21.505s)
[348.170125] [092/131] (704s left) kms_setmode (basic-clone-single-crtc)
[348.229096] Starting subtest: basic-clone-single-crtc
[348.235314] Subtest basic-clone-single-crtc: SKIP (0.000s)
[348.321961] [093/131] (704s left) gen7_exec_parse (oacontrol-tracking)
[348.379145] Subtest oacontrol-tracking: SKIP (0.000s)
[348.457485] [094/131] (704s left) prime_self_import (basic-llseek-bad)
[348.491663] Starting subtest: basic-llseek-bad
[348.517226] Subtest basic-llseek-bad: SUCCESS (0.025s)
[348.636853] [095/131] (704s left) gem_exec_balancer (full)
[348.717979] Starting subtest: full
[353.754386] Subtest full: SUCCESS (5.038s)
[354.055032] [096/131] (698s left) kms_flip (plain-flip-interruptible)
[354.158087] Starting subtest: plain-flip-interruptible
[354.160382] Starting dynamic subtest: A-eDP1
[355.887214] Dynamic subtest A-eDP1: SUCCESS (1.727s)
[355.898826] Starting dynamic subtest: B-eDP1
[357.614829] Dynamic subtest B-eDP1: SUCCESS (1.727s)
[357.626819] Starting dynamic subtest: C-eDP1
[359.330164] Dynamic subtest C-eDP1: SUCCESS (1.715s)
[359.339966] Starting dynamic subtest: D-eDP1
[361.053319] Dynamic subtest D-eDP1: SUCCESS (1.723s)
[361.055799] Subtest plain-flip-interruptible: SUCCESS (6.899s)
[362.210754] [097/131] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[362.320856] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[362.325086] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[362.421568] [098/131] (690s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[362.484378] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[362.486682] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[362.588553] [099/131] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[362.703421] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[362.707585] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[362.822116] [100/131] (690s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[362.931178] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[367.490098] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.561s)
[367.609018] [101/131] (685s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[367.701913] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[367.704152] Starting dynamic subtest: pipe-A-eDP-1
[367.726747] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.738810] Starting dynamic subtest: pipe-B-eDP-1
[367.760589] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.770080] Starting dynamic subtest: pipe-C-eDP-1
[367.792951] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.802136] Starting dynamic subtest: pipe-D-eDP-1
[367.824041] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.827940] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[369.821692] [102/131] (683s left) kms_atomic (plane-invalid-params)
[369.924799] Starting subtest: plane-invalid-params
[369.926712] Starting dynamic subtest: pipe-A-eDP-1
[370.320397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[370.322842] Subtest plane-invalid-params: SUCCESS (0.397s)
[371.141655] [103/131] (681s left) kms_flip (nonblocking-read)
[371.242795] Starting subtest: nonblocking-read
[371.245022] Subtest nonblocking-read: SUCCESS (0.000s)
[371.344470] [104/131] (681s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[371.461662] Starting subtest: fbcpsr-stridechange
[375.486737] Subtest fbcpsr-stridechange: SUCCESS (4.028s)
[375.628281] [105/131] (677s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[375.736592] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[375.740811] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[375.845631] [106/131] (677s left) gem_render_copy (y-tiled-ccs-to-linear)
[375.918148] Starting subtest: y-tiled-ccs-to-linear
[375.922905] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[376.102699] [107/131] (677s left) syncobj_wait (invalid-reset-zero-handles)
[376.170283] Starting subtest: invalid-reset-zero-handles
[376.172573] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[376.291308] [108/131] (676s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[376.399311] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[376.403904] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[376.502960] [109/131] (676s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[376.607716] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[376.610708] Starting dynamic subtest: pipe-A
[376.696660] Dynamic subtest pipe-A: SUCCESS (0.088s)
[376.707942] Starting dynamic subtest: pipe-B
[377.808547] Dynamic subtest pipe-B: SUCCESS (1.111s)
[377.820341] Starting dynamic subtest: pipe-C
[378.911196] Dynamic subtest pipe-C: SUCCESS (1.101s)
[378.923701] Starting dynamic subtest: pipe-D
[380.039356] Dynamic subtest pipe-D: SUCCESS (1.128s)
[380.041612] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.432s)
[381.191057] [110/131] (672s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[381.288553] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[381.290996] Starting dynamic subtest: pipe-A-eDP-1
[381.314709] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[381.325875] Starting dynamic subtest: pipe-B-eDP-1
[381.347888] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[381.357448] Starting dynamic subtest: pipe-C-eDP-1
[381.380011] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[381.389819] Starting dynamic subtest: pipe-D-eDP-1
[381.412655] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[381.417288] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[383.434042] [111/131] (669s left) api_intel_bb (purge-bb)
[383.508541] Starting subtest: purge-bb
[383.510911] Subtest purge-bb: SUCCESS (0.004s)
[383.647404] [112/131] (669s left) perf (invalid-oa-metric-set-id)
[383.770033] Starting subtest: invalid-oa-metric-set-id
[383.790496] Subtest invalid-oa-metric-set-id: SUCCESS (0.020s)
[383.828002] [113/131] (669s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[383.932999] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[383.935299] Starting dynamic subtest: pipe-A-eDP-1
[383.944418] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[383.955883] Starting dynamic subtest: pipe-B-eDP-1
[383.964866] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[383.974387] Starting dynamic subtest: pipe-C-eDP-1
[383.982855] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[383.994254] Starting dynamic subtest: pipe-D-eDP-1
[384.002810] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[384.007049] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[386.083814] [114/131] (667s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[386.193770] Starting subtest: psr-rgb565-draw-mmap-cpu
[390.883538] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (4.693s)
[390.994060] [115/131] (662s left) kms_cursor_crc (cursor-suspend)
[391.106212] Starting subtest: cursor-suspend
[391.108530] Starting dynamic subtest: pipe-A-eDP-1
[423.377979] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.064s)
[423.387434] Starting dynamic subtest: pipe-D-eDP-1
[456.376164] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.598s)
[456.378747] Subtest cursor-suspend: SUCCESS (6.664s)
[457.178792] [116/131] (655s left) kms_writeback (writeback-fb-id)
[457.292661] Subtest writeback-fb-id: SKIP (0.000s)
[457.342126] [117/131] (654s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[457.442175] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[460.519995] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (3.000s)
[460.643197] [118/131] (651s left) gem_pipe_control_store_loop (fresh-buffer)
[460.713828] Starting subtest: fresh-buffer
[462.908698] Subtest fresh-buffer: SUCCESS (2.152s)
[463.021130] [119/131] (649s left) gem_softpin (evict-single-offset)
[463.078018] Starting subtest: evict-single-offset
[490.403691] Subtest evict-single-offset: SUCCESS (27.204s)
[490.485300] [120/131] (622s left) gem_gtt_cpu_tlb
[490.643902] [121/131] (622s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[490.767669] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[490.772250] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[490.869117] [122/131] (621s left) i915_query (test-query-geometry-subslices)
[490.933760] Starting subtest: test-query-geometry-subslices
[490.936178] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[491.044212] [123/131] (621s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[491.164901] Starting subtest: cursorB-vs-flipA-toggle
[491.169405] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[491.317735] [124/131] (621s left) gem_exec_reloc (basic-range-active)
[491.374858] Subtest basic-range-active: SKIP (0.000s)
[491.437753] [125/131] (621s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[491.535504] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[491.539065] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[491.648892] [126/131] (621s left) kms_big_fb (linear-8bpp-rotate-90)
[491.759720] Starting subtest: linear-8bpp-rotate-90
[491.779276] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[491.899965] [127/131] (620s left) kms_flip (2x-flip-vs-wf_vblank)
[492.001694] Starting subtest: 2x-flip-vs-wf_vblank
[492.013251] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[492.090573] [128/131] (620s left) kms_dp_linktrain_fallback (dsc-fallback)
[492.201682] Starting subtest: dsc-fallback
[492.207101] Subtest dsc-fallback: SKIP (0.000s)
[492.271123] [129/131] (620s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[492.366213] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[492.370298] Starting dynamic subtest: A-eDP1
[501.301117] Dynamic subtest A-eDP1: SUCCESS (8.934s)
[501.310934] Starting dynamic subtest: B-eDP1
[510.229470] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[510.239942] Starting dynamic subtest: C-eDP1
[519.146468] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[519.159246] Starting dynamic subtest: D-eDP1
[528.072147] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[528.074593] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.703s)
[529.194929] [130/131] (583s left) perf_pmu (busy-start)
[529.240109] Starting subtest: busy-start
[529.242968] Starting dynamic subtest: rcs0
[531.788556] Dynamic subtest rcs0: SUCCESS (2.549s)
[531.800980] Starting dynamic subtest: bcs0
[534.338202] Dynamic subtest bcs0: SUCCESS (2.547s)
[534.350361] Starting dynamic subtest: vcs0
[538.401223] Dynamic subtest vcs0: SUCCESS (4.059s)
[538.413306] Starting dynamic subtest: vcs1
[542.433588] Dynamic subtest vcs1: SUCCESS (4.029s)
[542.444356] Starting dynamic subtest: vecs0
[546.401658] Dynamic subtest vecs0: SUCCESS (3.965s)
[546.414042] Starting dynamic subtest: ccs0
[548.951603] Dynamic subtest ccs0: SUCCESS (2.549s)
[548.954285] Subtest busy-start: SUCCESS (19.707s)
[549.062589] [131/131] (563s left) kms_pm_backlight (basic-brightness)
[549.175091] Starting subtest: basic-brightness
[549.234988] Starting dynamic subtest: eDP-1
[549.746454] Dynamic subtest eDP-1: SUCCESS (0.510s)
[549.748832] Subtest basic-brightness: SUCCESS (0.573s)
[550.527919] Closing watchdogs
Done.