[61.361284] Initializing watchdogs
[61.361329]   /dev/watchdog0
[61.374107] [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]
[61.378934] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.380985] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.382990] [001/130] (960s left) prime_busy (before-wait)
[61.525592] Starting subtest: before-wait
[61.531096] Starting dynamic subtest: rcs0
[61.584092] Dynamic subtest rcs0: SUCCESS (0.053s)
[61.592752] Starting dynamic subtest: bcs0
[61.668500] Dynamic subtest bcs0: SUCCESS (0.084s)
[61.675552] Starting dynamic subtest: vcs0
[61.710734] Dynamic subtest vcs0: SUCCESS (0.043s)
[61.717831] Starting dynamic subtest: vcs1
[61.753675] Dynamic subtest vcs1: SUCCESS (0.043s)
[61.758391] Starting dynamic subtest: vecs0
[61.795280] Dynamic subtest vecs0: SUCCESS (0.042s)
[61.801826] Starting dynamic subtest: ccs0
[61.838966] Dynamic subtest ccs0: SUCCESS (0.044s)
[61.947948] Subtest before-wait: SUCCESS (0.423s)
[62.013103] [002/130] (959s left) i915_query (hwconfig_table)
[62.073206] Starting subtest: hwconfig_table
[62.185058] Subtest hwconfig_table: SUCCESS (0.001s)
[62.213010] [003/130] (959s left) gem_wait (write-busy)
[62.273394] Starting subtest: write-busy
[62.274418] Starting dynamic subtest: all-engines
[62.904934] Dynamic subtest all-engines: SUCCESS (0.636s)
[62.917710] Starting dynamic subtest: rcs0
[63.453883] Dynamic subtest rcs0: SUCCESS (0.553s)
[63.464835] Starting dynamic subtest: bcs0
[64.002438] Dynamic subtest bcs0: SUCCESS (0.552s)
[64.014054] Starting dynamic subtest: vcs0
[65.963790] Dynamic subtest vcs0: SUCCESS (1.969s)
[65.974247] Starting dynamic subtest: vcs1
[67.948042] Dynamic subtest vcs1: SUCCESS (1.993s)
[67.958912] Starting dynamic subtest: vecs0
[69.930897] Dynamic subtest vecs0: SUCCESS (1.989s)
[69.942792] Starting dynamic subtest: ccs0
[70.480617] Dynamic subtest ccs0: SUCCESS (0.553s)
[70.481769] Subtest write-busy: SUCCESS (8.248s)
[70.669548] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[70.671375] [004/130] (951s left) kms_addfb_basic (invalid-get-prop)
[70.728375] Starting subtest: invalid-get-prop
[70.729569] Subtest invalid-get-prop: SUCCESS (0.000s)
[70.932824] [005/130] (951s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[76.371559] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[76.372813] Starting dynamic subtest: pipe-A-eDP-1
[82.913134] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.546s)
[82.919223] Starting dynamic subtest: pipe-B-eDP-1
[89.429172] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.512s)
[89.430220] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.062s)
[90.293970] [006/130] (931s left) kms_writeback (writeback-pixel-formats)
[90.385400] Subtest writeback-pixel-formats: SKIP (0.000s)
[90.420130] [007/130] (931s left) gem_render_copy (y-tiled-ccs-to-linear)
[90.472782] Starting subtest: y-tiled-ccs-to-linear
[90.474845] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[90.650334] [008/130] (931s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[90.752634] Starting subtest: psr-2p-pri-indfb-multidraw
[90.754304] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[90.829805] [009/130] (931s left) kms_properties (get_properties-sanity-non-atomic)
[90.928692] Starting subtest: get_properties-sanity-non-atomic
[90.931428] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[90.994235] [010/130] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[91.094910] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[95.633550] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.537s)
[95.759944] [011/130] (926s left) kms_selftest (drm_format_helper)
[95.794381] Starting subtest: drm_format_helper
[95.809927] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[95.930973] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.121s)
[95.938389] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[96.057117] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.126s)
[96.064251] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[96.150973] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.093s)
[96.158075] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[96.233925] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.083s)
[96.241221] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[96.346747] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.112s)
[96.353768] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[96.493824] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.146s)
[96.500886] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[96.602924] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.110s)
[96.610086] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[96.680791] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.078s)
[96.687950] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[96.795152] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.114s)
[96.802159] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[96.897163] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.103s)
[96.902931] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[97.044428] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.146s)
[97.051915] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[97.157910] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.112s)
[97.165107] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[97.230701] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.073s)
[97.236620] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[97.363805] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.132s)
[97.368951] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[97.485870] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.123s)
[97.491034] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[97.634579] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.143s)
[97.640751] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_build_fourcc_list
[97.760081] Dynamic subtest drm_format_helper_test-drm_test_fb_build_fourcc_list: SUCCESS (0.130s)
[97.765504] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[97.889221] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.129s)
[97.890096] Subtest drm_format_helper: SUCCESS (2.096s)
[98.064691] [012/130] (924s left) i915_pm_rps (reset)
[98.115681] Starting subtest: reset
[98.148122] Subtest reset: FAIL (0.009s)
[98.189181] [013/130] (923s left) gem_exec_whisper (basic-contexts-forked-all)
[98.256024] Starting subtest: basic-contexts-forked-all
[118.862514] Subtest basic-contexts-forked-all: SUCCESS (20.601s)
[119.035859] [014/130] (903s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[119.134441] Starting subtest: fbc-psr2-sprite-plane-onoff
[119.135394] Starting dynamic subtest: eDP-1
[119.161349] Dynamic subtest eDP-1: SKIP (0.000s)
[119.163409] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[119.199272] [015/130] (903s left) gem_exec_create (forked)
[119.259447] Starting subtest: forked
[119.260568] Starting dynamic subtest: smem
[139.947605] Dynamic subtest smem: SUCCESS (20.685s)
[139.949125] Subtest forked: SUCCESS (20.685s)
[140.122925] [016/130] (882s left) perf_pmu (init-sema)
[140.157325] Starting subtest: init-sema
[140.158529] Starting dynamic subtest: rcs0
[140.159590] Dynamic subtest rcs0: SUCCESS (0.002s)
[140.171600] Starting dynamic subtest: bcs0
[140.172550] Dynamic subtest bcs0: SUCCESS (0.001s)
[140.178562] Starting dynamic subtest: vcs0
[140.179565] Dynamic subtest vcs0: SUCCESS (0.001s)
[140.185463] Starting dynamic subtest: vcs1
[140.186379] Dynamic subtest vcs1: SUCCESS (0.001s)
[140.191868] Starting dynamic subtest: vecs0
[140.192698] Dynamic subtest vecs0: SUCCESS (0.001s)
[140.198093] Starting dynamic subtest: ccs0
[140.198983] Dynamic subtest ccs0: SUCCESS (0.000s)
[140.199806] Subtest init-sema: SUCCESS (0.006s)
[140.267422] [017/130] (882s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[140.364314] Starting subtest: yf-tiled-16bpp-rotate-180
[140.366082] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[140.459578] [018/130] (881s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[140.516658] Starting subtest: multi-wait-all-for-submit-submitted
[140.623915] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[140.690902] [019/130] (881s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[140.795358] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[140.797084] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[140.912742] [020/130] (881s left) kms_flip (2x-flip-vs-panning-interruptible)
[141.012793] Starting subtest: 2x-flip-vs-panning-interruptible
[141.024873] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[141.151270] [021/130] (881s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[141.247494] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[141.258911] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[141.334257] [022/130] (881s left) gem_lmem_swapping (random)
[141.370987] Subtest random: SKIP (0.000s)
[141.406628] [023/130] (881s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[141.503244] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[141.505132] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[141.589301] [024/130] (880s left) syncobj_timeline (wait-for-submit-delayed-submit)
[141.640119] Starting subtest: wait-for-submit-delayed-submit
[141.747405] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[141.812881] [025/130] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[141.909922] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[147.294390] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.384s)
[147.408177] [026/130] (875s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[147.501775] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[147.502970] Starting dynamic subtest: pipe-A-eDP-1
[147.511391] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[147.518605] Starting dynamic subtest: pipe-B-eDP-1
[147.526538] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[147.532906] Starting dynamic subtest: pipe-C-eDP-1
[147.540322] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[147.546057] Starting dynamic subtest: pipe-D-eDP-1
[147.553522] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[147.554357] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[149.652718] [027/130] (872s left) kms_psr (psr-sprite-mmap-cpu)
[149.754350] Starting subtest: psr-sprite-mmap-cpu
[149.755262] Starting dynamic subtest: eDP-1
[151.465059] Dynamic subtest eDP-1: SUCCESS (1.712s)
[151.465909] Subtest psr-sprite-mmap-cpu: SUCCESS (1.713s)
[152.296187] [028/130] (870s left) kms_vblank (ts-continuation-idle-hang)
[152.397726] Starting subtest: ts-continuation-idle-hang
[152.398844] Starting dynamic subtest: pipe-A-eDP-1
[178.656041] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.255s)
[178.664722] Starting dynamic subtest: pipe-D-eDP-1
[203.687236] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.028s)
[203.688073] Subtest ts-continuation-idle-hang: SUCCESS (51.287s)
[204.541121] [029/130] (818s left) gem_exec_schedule (semaphore-resolve)
[204.605777] Starting subtest: semaphore-resolve
[204.643819] Subtest semaphore-resolve: SUCCESS (0.038s)
[204.972085] [030/130] (817s left) gem_exec_params (invalid-bsd-ring)
[205.033329] Starting subtest: invalid-bsd-ring
[205.034472] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[205.130585] [031/130] (817s left) kms_plane_scaling (planes-downscale-factor-0-75)
[205.224783] Starting subtest: planes-downscale-factor-0-75
[205.225739] Starting dynamic subtest: pipe-A
[205.241777] Dynamic subtest pipe-A: SKIP (0.015s)
[205.248596] Starting dynamic subtest: pipe-B
[205.267812] Dynamic subtest pipe-B: SKIP (0.026s)
[205.274361] Starting dynamic subtest: pipe-C
[205.294640] Dynamic subtest pipe-C: SKIP (0.026s)
[205.300684] Starting dynamic subtest: pipe-D
[205.321764] Dynamic subtest pipe-D: SKIP (0.026s)
[205.323436] Subtest planes-downscale-factor-0-75: SKIP (0.095s)
[205.426806] [032/130] (817s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[205.531830] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[205.533660] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[205.640411] [033/130] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[205.746030] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[205.747843] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[205.863346] [034/130] (816s left) kms_pm_rpm (modeset-lpsp)
[208.120389] Starting subtest: modeset-lpsp
[209.567864] Subtest modeset-lpsp: SUCCESS (1.448s)
[209.651184] [035/130] (813s left) gem_eio (context-create)
[209.854918] Starting subtest: context-create
[210.159073] Subtest context-create: SUCCESS (0.305s)
[210.290629] [036/130] (812s left) kms_lease (simple-lease)
[210.385797] Starting subtest: simple-lease
[210.386836] Starting dynamic subtest: pipe-A-eDP-1
[210.908216] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.521s)
[210.917686] Starting dynamic subtest: pipe-B-eDP-1
[212.355448] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[212.362912] Starting dynamic subtest: pipe-C-eDP-1
[213.745857] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s)
[213.753281] Starting dynamic subtest: pipe-D-eDP-1
[215.143839] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.396s)
[215.144984] Subtest simple-lease: SUCCESS (4.757s)
[215.939765] [037/130] (806s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[216.051853] Starting subtest: psr-rgb565-draw-mmap-wc
[220.610240] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (4.559s)
[220.716203] [038/130] (802s left) kms_hdr (brightness-with-hdr)
[220.811644] Starting subtest: brightness-with-hdr
[220.814294] Subtest brightness-with-hdr: SKIP (0.000s)
[220.879323] [039/130] (802s left) gem_pread (uncached)
[220.935422] Subtest uncached: SKIP (0.000s)
[220.991410] [040/130] (802s left) gem_exec_reloc (basic-wc-cpu)
[221.039946] Subtest basic-wc-cpu: SKIP (0.000s)
[221.107793] [041/130] (801s left) perf (oa-formats)
[221.214624] Starting subtest: oa-formats
[221.215503] Starting dynamic subtest: 0-rcs0
[221.235629] Dynamic subtest 0-rcs0: SUCCESS (0.021s)
[221.243268] Starting dynamic subtest: 1-vecs0
[221.271341] Dynamic subtest 1-vecs0: SUCCESS (0.035s)
[221.272228] Subtest oa-formats: SUCCESS (0.057s)
[221.312757] [042/130] (801s left) gem_ctx_persistence (legacy-engines-hostile)
[221.374548] Starting subtest: legacy-engines-hostile
[221.375484] Starting dynamic subtest: render
[221.505320] Dynamic subtest render: SUCCESS (0.130s)
[221.516711] Starting dynamic subtest: bsd1
[221.628721] Dynamic subtest bsd1: SUCCESS (0.121s)
[221.639192] Starting dynamic subtest: bsd2
[221.706644] Dynamic subtest bsd2: SUCCESS (0.076s)
[221.716045] Starting dynamic subtest: blt
[221.867504] Dynamic subtest blt: SUCCESS (0.160s)
[221.878122] Starting dynamic subtest: vebox
[221.943640] Dynamic subtest vebox: SUCCESS (0.074s)
[221.944888] Subtest legacy-engines-hostile: SUCCESS (0.569s)
[222.057392] [043/130] (801s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[227.024530] Starting subtest: pr-cursor-plane-move-continuous-sf
[227.029196] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[227.881588] [044/130] (795s left) gem_exec_reloc (basic-write-wc-active)
[227.936921] Subtest basic-write-wc-active: SKIP (0.000s)
[227.996522] [045/130] (795s left) gem_exec_flush (basic-uc-ro-default)
[228.066543] Starting subtest: basic-uc-ro-default
[233.544744] Subtest basic-uc-ro-default: SUCCESS (5.478s)
[233.720161] [046/130] (789s left) kms_flip (2x-flip-vs-wf_vblank)
[233.820412] Starting subtest: 2x-flip-vs-wf_vblank
[233.831987] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[233.957072] [047/130] (789s left) gem_eio (suspend)
[234.181026] Starting subtest: suspend
[249.115286] Subtest suspend: SUCCESS (14.934s)
[254.237890] [048/130] (774s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[254.360560] Starting subtest: cursorA-vs-flipB-atomic
[254.362404] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[254.453734] [049/130] (773s left) gem_tiled_swapping (non-threaded)
[254.511914] Subtest non-threaded: SKIP (0.000s)
[254.561353] [050/130] (773s left) gem_ctx_engines (independent)
[254.618735] Starting subtest: independent
[254.619927] Starting dynamic subtest: rcs0
[254.755981] Dynamic subtest rcs0: SUCCESS (0.135s)
[254.766100] Starting dynamic subtest: bcs0
[254.900737] Dynamic subtest bcs0: SUCCESS (0.144s)
[254.908051] Starting dynamic subtest: vcs0
[255.055360] Dynamic subtest vcs0: SUCCESS (0.154s)
[255.062409] Starting dynamic subtest: vcs1
[255.211252] Dynamic subtest vcs1: SUCCESS (0.155s)
[255.218965] Starting dynamic subtest: vecs0
[255.357976] Dynamic subtest vecs0: SUCCESS (0.146s)
[255.367758] Starting dynamic subtest: ccs0
[255.515575] Dynamic subtest ccs0: SUCCESS (0.157s)
[255.523456] Starting dynamic subtest: all-engines
[256.150750] Dynamic subtest all-engines: SUCCESS (0.635s)
[256.151695] Subtest independent: SUCCESS (1.531s)
[257.953134] [051/130] (770s left) syncobj_wait (single-wait-for-submit-signaled)
[258.000177] Starting subtest: single-wait-for-submit-signaled
[258.002084] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[258.110324] [052/130] (770s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[258.214895] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[258.216997] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[259.348612] [053/130] (769s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[259.729049] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[260.547992] [054/130] (767s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[260.782906] Starting subtest: cursor-rapid-movement-256x256
[260.785550] Starting dynamic subtest: pipe-A-eDP-1
[261.338302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[261.361014] Starting dynamic subtest: pipe-D-eDP-1
[262.591151] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[262.592070] Subtest cursor-rapid-movement-256x256: SUCCESS (1.810s)
[263.427779] [055/130] (765s left) gem_exec_fence (basic-wait-all)
[263.490817] Starting subtest: basic-wait-all
[263.609376] Subtest basic-wait-all: SUCCESS (0.118s)
[265.973886] [056/130] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[266.083197] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[266.084892] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[266.187996] [057/130] (762s left) gem_eio (wait-wedge-10ms)
[266.413208] Starting subtest: wait-wedge-10ms
[268.020868] Subtest wait-wedge-10ms: SUCCESS (1.607s)
[268.136894] [058/130] (760s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[268.200957] Starting subtest: multi-wait-all-for-submit-available-signaled
[268.202150] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[268.298344] [059/130] (760s left) kms_atomic (crtc-invalid-params-fence)
[268.397834] Starting subtest: crtc-invalid-params-fence
[268.398931] Starting dynamic subtest: pipe-A-eDP-1
[268.794413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.394s)
[268.795513] Subtest crtc-invalid-params-fence: SUCCESS (0.396s)
[269.649305] [060/130] (758s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[269.707322] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[269.765740] [061/130] (758s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[269.850970] Starting subtest: primary-yf-tiled-reflect-x-270
[269.852968] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[269.917552] [062/130] (758s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[269.983219] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[270.087874] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[270.156097] [063/130] (758s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[270.263108] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[275.436968] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.174s)
[275.542827] [064/130] (753s left) perf (gen12-oa-tlb-invalidate)
[275.627521] Starting subtest: gen12-oa-tlb-invalidate
[275.628698] Starting dynamic subtest: 0-rcs0
[285.676160] Dynamic subtest 0-rcs0: SUCCESS (10.045s)
[285.684074] Starting dynamic subtest: 1-vecs0
[295.724396] Dynamic subtest 1-vecs0: SUCCESS (10.046s)
[295.725483] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.093s)
[295.769094] [065/130] (733s left) kms_cdclk (mode-transition)
[295.873127] Starting subtest: mode-transition
[295.874691] Starting dynamic subtest: pipe-A-eDP-1
[296.171055] Dynamic subtest pipe-A-eDP-1: SKIP (0.295s)
[296.179510] Starting dynamic subtest: pipe-B-eDP-1
[296.181638] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[296.190151] Starting dynamic subtest: pipe-C-eDP-1
[296.192071] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[296.199103] Starting dynamic subtest: pipe-D-eDP-1
[296.200895] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[296.202670] Subtest mode-transition: SKIP (0.302s)
[297.030289] [066/130] (731s left) kms_pipe_stress (stress-xrgb8888-untiled)
[297.121069] Starting subtest: stress-xrgb8888-untiled
[303.147787] Subtest stress-xrgb8888-untiled: SUCCESS (6.026s)
[303.200528] [067/130] (725s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[303.265615] Starting subtest: yf-tiled-to-vebox-y-tiled
[303.267764] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[303.442538] [068/130] (725s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[303.540709] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[303.542768] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[303.649392] [069/130] (725s left) gem_userptr_blits (sync-unmap-after-close)
[303.704595] Starting subtest: sync-unmap-after-close
[303.715917] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[303.860297] [070/130] (725s left) kms_psr (fbc-psr2-cursor-blt)
[303.951512] Starting subtest: fbc-psr2-cursor-blt
[303.952583] Starting dynamic subtest: eDP-1
[303.954495] Dynamic subtest eDP-1: SKIP (0.000s)
[303.956377] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[304.015085] [071/130] (724s left) gem_exec_schedule (implicit-write-read)
[304.080386] Starting subtest: implicit-write-read
[304.081544] Starting dynamic subtest: rcs0
[304.189784] Dynamic subtest rcs0: SUCCESS (0.108s)
[304.201611] Starting dynamic subtest: vcs0
[304.273882] Dynamic subtest vcs0: SUCCESS (0.084s)
[304.284455] Starting dynamic subtest: vcs1
[304.346469] Dynamic subtest vcs1: SUCCESS (0.072s)
[304.356730] Starting dynamic subtest: vecs0
[304.418557] Dynamic subtest vecs0: SUCCESS (0.071s)
[304.428119] Starting dynamic subtest: ccs0
[304.507417] Dynamic subtest ccs0: SUCCESS (0.089s)
[304.508481] Subtest implicit-write-read: SUCCESS (0.428s)
[305.985100] [072/130] (723s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[306.081765] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[306.082685] Starting dynamic subtest: pipe-A
[306.088583] Dynamic subtest pipe-A: SKIP (0.004s)
[306.095870] Starting dynamic subtest: pipe-B
[306.103295] Dynamic subtest pipe-B: SKIP (0.015s)
[306.110720] Starting dynamic subtest: pipe-C
[306.119082] Dynamic subtest pipe-C: SKIP (0.016s)
[306.125923] Starting dynamic subtest: pipe-D
[306.134732] Dynamic subtest pipe-D: SKIP (0.015s)
[306.136482] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.051s)
[306.248299] [073/130] (722s left) api_intel_allocator (fork-simple-stress-signal)
[306.298991] Starting subtest: fork-simple-stress-signal
[311.713878] Subtest fork-simple-stress-signal: SUCCESS (5.413s)
[311.826999] [074/130] (717s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[311.936601] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[312.913985] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.978s)
[313.044446] [075/130] (716s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[313.150992] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[313.151947] Starting dynamic subtest: pipe-A-eDP-1
[313.165262] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[313.173247] Starting dynamic subtest: pipe-B-eDP-1
[313.181560] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[313.188759] Starting dynamic subtest: pipe-C-eDP-1
[313.196919] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[313.204301] Starting dynamic subtest: pipe-D-eDP-1
[313.212564] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[313.214316] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[315.277733] [076/130] (713s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[315.398728] Starting subtest: cursorB-vs-flipA-varying-size
[315.400592] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[315.527270] [077/130] (713s left) kms_cursor_edge_walk (256x256-right-edge)
[315.629743] Starting subtest: 256x256-right-edge
[315.630612] Starting dynamic subtest: pipe-A-eDP-1
[319.019039] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.387s)
[319.026723] Starting dynamic subtest: pipe-D-eDP-1
[322.133211] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s)
[322.134402] Subtest 256x256-right-edge: SUCCESS (6.503s)
[322.952191] [078/130] (706s left) gem_spin_batch (legacy-resubmit-new)
[323.013188] Starting subtest: legacy-resubmit-new
[323.014082] Starting dynamic subtest: default
[323.021134] Dynamic subtest default: SUCCESS (0.007s)
[323.029639] Starting dynamic subtest: render
[323.030565] Dynamic subtest render: SUCCESS (0.003s)
[323.037698] Starting dynamic subtest: bsd
[323.038564] Dynamic subtest bsd: SUCCESS (0.003s)
[323.045735] Starting dynamic subtest: bsd1
[323.046618] Dynamic subtest bsd1: SUCCESS (0.004s)
[323.053682] Starting dynamic subtest: bsd2
[323.054548] Dynamic subtest bsd2: SUCCESS (0.002s)
[323.061647] Starting dynamic subtest: blt
[323.062456] Dynamic subtest blt: SUCCESS (0.004s)
[323.069491] Starting dynamic subtest: vebox
[323.070325] Dynamic subtest vebox: SUCCESS (0.004s)
[323.071196] Subtest legacy-resubmit-new: SUCCESS (0.031s)
[324.938079] [079/130] (704s left) i915_pm_freq_api (freq-suspend)
[324.985078] Starting subtest: freq-suspend
[324.986136] Starting dynamic subtest: gt0
[341.789500] Dynamic subtest gt0: SUCCESS (1.207s)
[341.798583] Starting dynamic subtest: gt1
[357.729404] Dynamic subtest gt1: SUCCESS (1.118s)
[357.731037] Subtest freq-suspend: SUCCESS (2.327s)
[358.796315] [080/130] (701s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[358.907098] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[360.162947] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.292s)
[360.378865] [081/130] (700s left) kms_psr (fbc-psr-suspend)
[360.484047] Starting subtest: fbc-psr-suspend
[360.485141] Starting dynamic subtest: eDP-1
[360.487101] Dynamic subtest eDP-1: SKIP (0.000s)
[360.488947] Subtest fbc-psr-suspend: SKIP (0.001s)
[360.550168] [082/130] (700s left) gem_exec_balancer (full-late-pulse)
[360.608165] Starting subtest: full-late-pulse
[365.121445] Subtest full-late-pulse: SUCCESS (4.597s)
[365.444598] [083/130] (695s left) gem_exec_reloc (basic-gtt-wc)
[365.507548] Subtest basic-gtt-wc: SKIP (0.000s)
[365.558839] [084/130] (695s left) gem_exec_fence (parallel)
[365.734834] Starting subtest: parallel
[365.736190] Starting dynamic subtest: rcs0
[367.862933] Dynamic subtest rcs0: SUCCESS (2.151s)
[367.871610] Starting dynamic subtest: bcs0
[369.998443] Dynamic subtest bcs0: SUCCESS (2.152s)
[370.007344] Starting dynamic subtest: vcs0
[372.138450] Dynamic subtest vcs0: SUCCESS (2.153s)
[372.148049] Starting dynamic subtest: vcs1
[374.278844] Dynamic subtest vcs1: SUCCESS (2.150s)
[374.291256] Starting dynamic subtest: vecs0
[376.421763] Dynamic subtest vecs0: SUCCESS (2.151s)
[376.430057] Starting dynamic subtest: ccs0
[378.568248] Dynamic subtest ccs0: SUCCESS (2.152s)
[378.569364] Subtest parallel: SUCCESS (12.914s)
[379.434292] [085/130] (681s left) kms_flip (nonexisting-fb-interruptible)
[379.532583] Starting subtest: nonexisting-fb-interruptible
[379.534847] Starting dynamic subtest: A-eDP1
[380.692576] Dynamic subtest A-eDP1: SUCCESS (1.160s)
[380.700793] Starting dynamic subtest: B-eDP1
[381.819920] Dynamic subtest B-eDP1: SUCCESS (1.129s)
[381.828253] Starting dynamic subtest: C-eDP1
[382.944490] Dynamic subtest C-eDP1: SUCCESS (1.126s)
[382.952195] Starting dynamic subtest: D-eDP1
[384.074806] Dynamic subtest D-eDP1: SUCCESS (1.131s)
[384.077264] Subtest nonexisting-fb-interruptible: SUCCESS (4.552s)
[385.231343] [086/130] (675s left) gem_exec_reloc (basic-write-cpu-active)
[385.286020] Subtest basic-write-cpu-active: SKIP (0.000s)
[385.369060] [087/130] (675s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[385.464688] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[385.465722] Starting dynamic subtest: pipe-A-default-mode
[386.600574] Dynamic subtest pipe-A-default-mode: SKIP (1.132s)
[386.603227] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.134s)
[386.749760] [088/130] (673s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[386.876630] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[417.618210] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.739s)
[418.481073] [089/130] (642s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[418.579839] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[418.581074] Starting dynamic subtest: pipe-A-eDP-1
[419.479742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.895s)
[419.487191] Starting dynamic subtest: pipe-B-eDP-1
[421.015075] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.533s)
[421.022914] Starting dynamic subtest: pipe-C-eDP-1
[422.480981] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.466s)
[422.489001] Starting dynamic subtest: pipe-D-eDP-1
[423.915810] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.435s)
[423.916702] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.334s)
[425.090792] [090/130] (635s left) kms_flip_event_leak (basic)
[425.187732] Starting subtest: basic
[425.189040] Starting dynamic subtest: pipe-A-eDP-1
[425.650959] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s)
[425.659466] Starting dynamic subtest: pipe-B-eDP-1
[426.828722] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.176s)
[426.836798] Starting dynamic subtest: pipe-C-eDP-1
[427.934334] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[427.944042] Starting dynamic subtest: pipe-D-eDP-1
[429.054574] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[429.056066] Subtest basic: SUCCESS (3.868s)
[429.894937] [091/130] (630s left) kms_dsc (dsc-with-bpc-formats)
[429.999722] Starting subtest: dsc-with-bpc-formats
[430.047755] Subtest dsc-with-bpc-formats: SKIP (0.004s)
[430.075663] [092/130] (630s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[430.122508] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[430.228152] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[430.296784] [093/130] (630s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[430.394824] Starting subtest: fbc-rgb101010-draw-mmap-wc
[433.974249] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.581s)
[434.085313] [094/130] (626s left) kms_flip (absolute-wf_vblank-interruptible)
[434.175694] Starting subtest: absolute-wf_vblank-interruptible
[434.178209] Starting dynamic subtest: A-eDP1
[442.875297] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[442.885243] Starting dynamic subtest: B-eDP1
[451.596857] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[451.606330] Starting dynamic subtest: C-eDP1
[460.314027] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[460.324321] Starting dynamic subtest: D-eDP1
[469.042235] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[469.045382] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.869s)
[470.240858] [095/130] (590s left) sysfs_timeslice_duration (timeout)
[470.305619] Starting subtest: timeout
[470.307149] Starting dynamic subtest: vecs0
[480.319841] Dynamic subtest vecs0: SUCCESS (10.012s)
[480.330564] Starting dynamic subtest: ccs0
[481.555316] Dynamic subtest ccs0: SUCCESS (1.233s)
[481.563962] Starting dynamic subtest: vcs0
[491.339600] Dynamic subtest vcs0: SUCCESS (9.780s)
[491.350998] Starting dynamic subtest: bcs0
[492.079968] Dynamic subtest bcs0: SUCCESS (0.741s)
[492.088569] Starting dynamic subtest: rcs0
[493.429755] Dynamic subtest rcs0: SUCCESS (1.349s)
[493.439310] Starting dynamic subtest: vcs1
[503.367484] Dynamic subtest vcs1: SUCCESS (9.934s)
[503.369196] Subtest timeout: SUCCESS (33.058s)
[503.439328] [096/130] (557s left) kms_color (ctm-0-25)
[503.541376] Starting subtest: ctm-0-25
[503.542559] Starting dynamic subtest: pipe-A-eDP-1
[507.023731] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.482s)
[507.031952] Starting dynamic subtest: pipe-B-eDP-1
[511.248989] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.226s)
[511.256867] Starting dynamic subtest: pipe-C-eDP-1
[518.275188] Dynamic subtest pipe-C-eDP-1: FAIL (6.771s)
[518.283602] Starting dynamic subtest: pipe-D-eDP-1
[525.078369] Dynamic subtest pipe-D-eDP-1: FAIL (6.811s)
[525.079339] Subtest ctm-0-25: FAIL (21.292s)
[525.663130] [097/130] (535s left) gem_softpin (allocator-evict)
[525.729279] Starting subtest: allocator-evict
[525.730849] Starting dynamic subtest: rcs0
[551.314958] Dynamic subtest rcs0: SUCCESS (25.588s)
[551.326460] Starting dynamic subtest: bcs0
[577.265826] Dynamic subtest bcs0: SUCCESS (25.955s)
[577.277363] Starting dynamic subtest: vcs0
[602.803299] Dynamic subtest vcs0: SUCCESS (25.530s)
[602.813867] Starting dynamic subtest: vcs1
[628.376151] Dynamic subtest vcs1: SUCCESS (25.566s)
[628.387273] Starting dynamic subtest: vecs0
[653.999008] Dynamic subtest vecs0: SUCCESS (25.620s)
[654.009430] Starting dynamic subtest: ccs0
[680.018965] Dynamic subtest ccs0: SUCCESS (26.019s)
[680.020501] Subtest allocator-evict: SUCCESS (154.288s)
[680.095114] [098/130] (380s left) gem_mmap_offset (bad-extensions)
[680.176142] Starting subtest: bad-extensions
[680.177409] Subtest bad-extensions: SUCCESS (0.000s)
[680.287935] [099/130] (380s left) core_getversion (all-cards)
[680.322540] Starting subtest: all-cards
[682.548409] Subtest all-cards: SUCCESS (2.228s)
[682.591250] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.amdgpu: true
[682.591933] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.xe: true
[682.594839] [100/130] (378s left) gem_ctx_persistence (engines-mixed)
[682.651248] Starting subtest: engines-mixed
[682.652881] Starting dynamic subtest: rcs0
[682.763508] Dynamic subtest rcs0: SUCCESS (0.112s)
[682.778974] Starting dynamic subtest: bcs0
[682.836600] Dynamic subtest bcs0: SUCCESS (0.071s)
[682.847401] Starting dynamic subtest: vcs0
[682.907641] Dynamic subtest vcs0: SUCCESS (0.069s)
[682.918455] Starting dynamic subtest: vcs1
[682.981441] Dynamic subtest vcs1: SUCCESS (0.072s)
[682.991594] Starting dynamic subtest: vecs0
[683.070066] Dynamic subtest vecs0: SUCCESS (0.087s)
[683.080834] Starting dynamic subtest: ccs0
[683.161388] Dynamic subtest ccs0: SUCCESS (0.089s)
[683.162984] Subtest engines-mixed: SUCCESS (0.511s)
[683.238735] [101/130] (377s left) kms_cursor_crc (cursor-random-512x170)
[683.510498] Starting subtest: cursor-random-512x170
[683.513692] Subtest cursor-random-512x170: SKIP (0.001s)
[683.646389] [102/130] (377s left) prime_vgem (coherency-gtt)
[683.724203] Starting subtest: coherency-gtt
[683.727267] Subtest coherency-gtt: SKIP (0.000s)
[683.812834] [103/130] (377s left) dmabuf_sync_file (import-basic)
[683.859629] Starting subtest: import-basic
[683.860941] Subtest import-basic: SUCCESS (0.003s)
[683.909352] [104/130] (377s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[684.000199] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[684.002242] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[684.102248] [105/130] (377s left) kms_getfb (getfb-handle-closed)
[684.154257] Starting subtest: getfb-handle-closed
[684.155583] Subtest getfb-handle-closed: SUCCESS (0.000s)
[684.255829] [106/130] (377s left) kms_addfb_basic (small-bo)
[684.344690] Starting subtest: small-bo
[684.345739] Subtest small-bo: SUCCESS (0.000s)
[684.450379] [107/130] (376s left) gen9_exec_parse (unaligned-access)
[684.514877] Subtest unaligned-access: SKIP (0.000s)
[684.578064] [108/130] (376s left) gem_exec_capture (userptr)
[684.637446] Starting subtest: userptr
[685.465341] Subtest userptr: SUCCESS (0.828s)
[685.601009] [109/130] (375s left) kms_atomic_transition (modeset-transition-nonblocking)
[685.693307] Starting subtest: modeset-transition-nonblocking
[685.694438] Starting dynamic subtest: 1x-outputs
[696.249518] Dynamic subtest 1x-outputs: SUCCESS (10.555s)
[696.524305] Subtest modeset-transition-nonblocking: SUCCESS (10.830s)
[697.372210] [110/130] (364s left) kms_content_protection (dp-mst-lic-type-1)
[697.548344] Starting subtest: dp-mst-lic-type-1
[697.551290] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[697.704853] [111/130] (363s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[698.226292] Starting subtest: syncobj-backward-timeline-chain-engines
[698.317576] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.093s)
[699.431370] [112/130] (362s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[699.533908] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[699.535994] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[699.645607] [113/130] (361s left) kms_psr (pr-sprite-plane-onoff)
[699.745841] Starting subtest: pr-sprite-plane-onoff
[699.748027] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[699.811935] [114/130] (361s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[704.822843] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[704.831360] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.007s)
[705.681467] [115/130] (355s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[705.774272] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[705.776367] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[705.888241] [116/130] (355s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[705.986427] Starting subtest: fbcpsr-rgb101010-draw-blt
[710.687977] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.704s)
[710.829467] [117/130] (350s left) kms_chamelium_frames (vga-frame-dump)
[711.212324] Subtest vga-frame-dump: SKIP (0.000s)
[712.025185] [118/130] (349s left) drm_mm (drm_mm)
[712.062114] Starting subtest: drm_mm
[712.069315] Starting dynamic subtest: drm_test_mm_init
[712.225174] Dynamic subtest drm_test_mm_init: SUCCESS (0.155s)
[712.241216] Starting dynamic subtest: drm_test_mm_debug
[712.352255] Dynamic subtest drm_test_mm_debug: SUCCESS (0.127s)
[712.362978] Starting dynamic subtest: drm_test_mm_align32
[712.483614] Dynamic subtest drm_test_mm_align32: SUCCESS (0.129s)
[712.491780] Starting dynamic subtest: drm_test_mm_align64
[712.616189] Dynamic subtest drm_test_mm_align64: SUCCESS (0.133s)
[712.623792] Starting dynamic subtest: drm_test_mm_lowest
[712.764051] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.147s)
[712.772618] Starting dynamic subtest: drm_test_mm_highest
[712.905123] Dynamic subtest drm_test_mm_highest: SUCCESS (0.138s)
[712.906245] Subtest drm_mm: SUCCESS (0.843s)
[713.097454] [119/130] (348s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[713.205165] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[718.162857] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.957s)
[718.304880] [120/130] (343s left) kms_invalid_mode (bad-hsync-end)
[718.409056] Starting subtest: bad-hsync-end
[718.410197] Starting dynamic subtest: pipe-A-eDP-1
[718.690459] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[718.701602] Starting dynamic subtest: pipe-B-eDP-1
[718.703153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[718.711450] Starting dynamic subtest: pipe-C-eDP-1
[718.712879] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[718.721321] Starting dynamic subtest: pipe-D-eDP-1
[718.722839] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[718.724116] Subtest bad-hsync-end: SUCCESS (0.287s)
[719.517904] [121/130] (342s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[719.620995] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[719.623145] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[719.738207] [122/130] (342s left) kms_big_fb (linear-64bpp-rotate-0)
[719.836143] Starting subtest: linear-64bpp-rotate-0
[722.247182] Subtest linear-64bpp-rotate-0: SUCCESS (2.411s)
[722.487736] [123/130] (339s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[722.583947] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[722.586393] Starting dynamic subtest: A-eDP1
[726.115400] Dynamic subtest A-eDP1: SUCCESS (3.528s)
[726.124629] Starting dynamic subtest: B-eDP1
[729.188292] Dynamic subtest B-eDP1: SUCCESS (3.073s)
[729.197989] Starting dynamic subtest: C-eDP1
[732.276399] Dynamic subtest C-eDP1: SUCCESS (3.088s)
[732.284692] Starting dynamic subtest: D-eDP1
[735.349034] Dynamic subtest D-eDP1: SUCCESS (3.072s)
[735.350230] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.768s)
[736.148794] [124/130] (325s left) perf_pmu (all-busy-check-all)
[736.185617] Starting subtest: all-busy-check-all
[737.335989] Subtest all-busy-check-all: SUCCESS (1.148s)
[737.484842] [125/130] (324s left) gem_ppgtt (shrink-vs-evict-pinned)
[737.548257] Starting subtest: shrink-vs-evict-pinned
[743.327124] Subtest shrink-vs-evict-pinned: SUCCESS (5.778s)
[743.413568] [126/130] (318s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[743.466304] Starting subtest: multi-wait-for-submit-submitted-signaled
[743.467609] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[743.552282] [127/130] (318s left) gem_basic (multigpu-create-close)
[743.606215] Starting subtest: multigpu-create-close
[743.608485] Subtest multigpu-create-close: SKIP (0.000s)
[743.709999] [128/130] (318s left) gem_exec_schedule (reorder-wide)
[743.896799] Subtest reorder-wide: SKIP (0.000s)
[744.077346] [129/130] (318s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[744.177285] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[744.180103] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[744.294113] [130/130] (317s left) kms_pm_dc (dc3co-vpb-simulation)
[745.396607] Starting subtest: dc3co-vpb-simulation
[754.514980] Subtest dc3co-vpb-simulation: SKIP (9.116s)
[754.617317] Closing watchdogs
Done.