[41.666357] Initializing watchdogs
[41.666497]   /dev/watchdog0
[41.680299] [001/143] (960s left) kms_addfb_basic (bad-pitch-999)
[41.749511] Starting subtest: bad-pitch-999
[41.752544] Subtest bad-pitch-999: SUCCESS (0.000s)
[41.857207] [002/143] (960s left) gen7_exec_parse (cmd-crossing-page)
[41.938376] Subtest cmd-crossing-page: SKIP (0.000s)
[41.961751] [003/143] (960s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[42.354729] Starting subtest: pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[42.357355] Subtest pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[43.233981] [004/143] (959s left) gem_exec_balancer (full-late)
[43.286606] Starting subtest: full-late
[48.009864] Subtest full-late: SUCCESS (4.726s)
[48.247275] [005/143] (954s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-ccs)
[48.628691] Starting subtest: pipe-C-crc-sprite-planes-basic-y-tiled-ccs
[48.634777] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.001s)
[49.493988] [006/143] (952s left) kms_psr2_sf (primary-plane-update-sf-dmg-area)
[54.741282] Starting subtest: primary-plane-update-sf-dmg-area
[54.744216] Starting dynamic subtest: pipe-A-eDP-1
[61.568274] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.827s)
[61.581530] Starting dynamic subtest: pipe-B-eDP-1
[68.353759] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.781s)
[68.356184] Subtest primary-plane-update-sf-dmg-area: SUCCESS (13.614s)
[69.280208] [007/143] (933s left) gem_mmap (bad-size)
[69.349128] Subtest bad-size: SKIP (0.000s)
[69.370516] [008/143] (932s left) gem_exec_whisper (basic-contexts-all)
[69.430051] Starting subtest: basic-contexts-all
[87.526493] Subtest basic-contexts-all: SUCCESS (18.093s)
[87.705372] [009/143] (914s left) syncobj_basic (bad-flags-handle-to-fd)
[87.761791] Starting subtest: bad-flags-handle-to-fd
[87.764100] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[87.827114] [010/143] (914s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[87.881164] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[92.381408] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.502s)
[92.490232] [011/143] (909s left) gem_ctx_shared (disjoint-timelines)
[92.560792] Starting subtest: disjoint-timelines
[92.594405] Subtest disjoint-timelines: SUCCESS (0.035s)
[92.813558] [012/143] (909s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[92.891393] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[92.896550] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[92.958472] [013/143] (909s left) kms_plane_lowres (tiling-4)
[93.054273] Starting subtest: tiling-4
[93.057044] Starting dynamic subtest: pipe-A-eDP-1
[93.062062] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.353677] Starting dynamic subtest: pipe-B-eDP-1
[93.358406] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.364570] Starting dynamic subtest: pipe-C-eDP-1
[93.369253] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.375323] Starting dynamic subtest: pipe-D-eDP-1
[93.379067] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.382845] Subtest tiling-4: SKIP (0.301s)
[94.240439] [014/143] (908s left) gem_ctx_sseu (invalid-sseu)
[94.315898] Subtest invalid-sseu: SKIP (0.000s)
[94.341906] [015/143] (908s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[94.457518] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[94.461875] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[94.543525] [016/143] (908s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[94.943951] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[94.949254] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s)
[95.776374] [017/143] (906s left) gem_ctx_isolation (clean)
[95.829135] Starting subtest: clean
[95.831641] Starting dynamic subtest: rcs0
[95.854279] Dynamic subtest rcs0: SUCCESS (0.028s)
[95.862650] Starting dynamic subtest: bcs0
[95.921950] Dynamic subtest bcs0: SUCCESS (0.068s)
[95.936872] Starting dynamic subtest: vcs0
[95.974951] Dynamic subtest vcs0: SUCCESS (0.053s)
[95.990295] Starting dynamic subtest: vcs1
[97.453562] Dynamic subtest vcs1: SUCCESS (1.478s)
[97.471164] Starting dynamic subtest: vecs0
[99.447644] Dynamic subtest vecs0: SUCCESS (1.994s)
[99.462236] Starting dynamic subtest: ccs0
[101.421728] Dynamic subtest ccs0: SUCCESS (1.974s)
[101.424393] Subtest clean: SUCCESS (5.595s)
[101.645534] [018/143] (900s left) kms_fbcon_fbt (fbc)
[101.709614] Starting subtest: fbc
[107.210300] Subtest fbc: SUCCESS (5.502s)
[107.281778] [019/143] (895s left) vgem_basic (setversion)
[107.363771] Starting subtest: setversion
[107.369497] Subtest setversion: SUCCESS (0.000s)
[107.416972] [020/143] (895s left) gem_exec_schedule (pi-common)
[107.607111] Starting subtest: pi-common
[107.609249] Starting dynamic subtest: rcs0
[107.696656] Dynamic subtest rcs0: SUCCESS (0.092s)
[107.722162] Starting dynamic subtest: bcs0
[107.780141] Dynamic subtest bcs0: SUCCESS (0.083s)
[107.804103] Starting dynamic subtest: vcs0
[107.864290] Dynamic subtest vcs0: SUCCESS (0.083s)
[107.888661] Starting dynamic subtest: vcs1
[107.948198] Dynamic subtest vcs1: SUCCESS (0.083s)
[107.972343] Starting dynamic subtest: vecs0
[108.032138] Dynamic subtest vecs0: SUCCESS (0.083s)
[108.056260] Starting dynamic subtest: ccs0
[108.115283] Dynamic subtest ccs0: SUCCESS (0.083s)
[108.118065] Subtest pi-common: SUCCESS (0.512s)
[108.336407] [021/143] (894s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-mc-ccs)
[108.722171] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs
[108.727701] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[109.593144] [022/143] (893s left) gem_pxp (fail-invalid-protected-context)
[112.166683] Subtest fail-invalid-protected-context: SKIP (0.000s)
[112.235555] [023/143] (890s left) gem_exec_whisper (basic-forked-all)
[112.304921] Starting subtest: basic-forked-all
[136.470872] Subtest basic-forked-all: SUCCESS (24.165s)
[136.651097] [024/143] (866s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[136.756724] Starting subtest: 4-tiled-32bpp-rotate-270
[136.780690] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.023s)
[136.873492] [025/143] (865s left) kms_getfb (getfb-repeated-different-handles)
[136.934857] Starting subtest: getfb-repeated-different-handles
[136.937461] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[137.018567] [026/143] (865s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[137.089555] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[137.093525] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[137.180626] [027/143] (865s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[137.270857] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[137.325212] [028/143] (865s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[137.753963] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[137.759730] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.001s)
[138.571053] [029/143] (864s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[138.649814] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[138.655089] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[138.728124] [030/143] (864s left) i915_hangman (gt-error-state-capture)
[138.800881] Starting subtest: gt-error-state-capture
[138.803615] Starting dynamic subtest: rcs0
[150.405989] Dynamic subtest rcs0: SUCCESS (11.605s)
[150.421899] Starting dynamic subtest: bcs0
[162.437042] Dynamic subtest bcs0: SUCCESS (12.031s)
[162.453305] Starting dynamic subtest: vcs0
[174.404688] Dynamic subtest vcs0: SUCCESS (11.967s)
[174.421146] Starting dynamic subtest: vcs1
[186.437138] Dynamic subtest vcs1: SUCCESS (12.031s)
[186.454569] Starting dynamic subtest: vecs0
[198.405192] Dynamic subtest vecs0: SUCCESS (11.968s)
[198.421745] Starting dynamic subtest: ccs0
[210.436649] Dynamic subtest ccs0: SUCCESS (12.031s)
[210.439771] Subtest gt-error-state-capture: SUCCESS (71.637s)
[210.545098] [031/143] (792s left) vc4/vc4_perfmon (get-values-invalid-perfmon)
[210.624240] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[210.671419] [032/143] (792s left) kms_psr (fbc-psr-sprite-plane-move)
[210.723543] Starting subtest: fbc-psr-sprite-plane-move
[210.726392] Starting dynamic subtest: eDP-1
[210.730967] Dynamic subtest eDP-1: SKIP (0.000s)
[210.735086] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[210.821955] [033/143] (792s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[210.895478] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[210.899470] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[210.979673] [034/143] (792s left) kms_dp_aux_dev
[211.188742] [035/143] (791s left) gem_spin_batch (legacy)
[211.233941] Starting subtest: legacy
[211.235973] Starting dynamic subtest: default
[214.471506] Dynamic subtest default: SUCCESS (3.234s)
[214.487718] Starting dynamic subtest: render
[217.704792] Dynamic subtest render: SUCCESS (3.232s)
[217.721971] Starting dynamic subtest: bsd
[220.946414] Dynamic subtest bsd: SUCCESS (3.240s)
[220.963171] Starting dynamic subtest: bsd1
[224.185578] Dynamic subtest bsd1: SUCCESS (3.237s)
[224.201857] Starting dynamic subtest: bsd2
[227.415187] Dynamic subtest bsd2: SUCCESS (3.230s)
[227.431623] Starting dynamic subtest: blt
[230.651808] Dynamic subtest blt: SUCCESS (3.236s)
[230.667720] Starting dynamic subtest: vebox
[233.889704] Dynamic subtest vebox: SUCCESS (3.236s)
[233.892304] Subtest legacy: SUCCESS (22.653s)
[234.517312] [036/143] (768s left) gem_exec_params (dr4-dirt)
[234.581809] Starting subtest: DR4-dirt
[234.584217] Subtest DR4-dirt: SUCCESS (0.000s)
[234.685352] [037/143] (768s left) kms_cursor_crc (cursor-offscreen-128x42)
[234.904090] Starting subtest: cursor-offscreen-128x42
[234.909199] Starting dynamic subtest: pipe-A-eDP-1
[237.006843] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.097s)
[237.061264] Starting dynamic subtest: pipe-D-eDP-1
[239.742570] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.694s)
[239.744935] Subtest cursor-offscreen-128x42: SUCCESS (4.838s)
[240.628957] [038/143] (762s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[240.733556] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[240.738449] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.003s)
[240.872594] [039/143] (762s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[240.979813] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[244.007977] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (3.031s)
[244.130791] [040/143] (759s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[244.213485] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[246.953519] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.738s)
[247.097993] [041/143] (756s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[247.161187] Starting subtest: compare-crc-sanitycheck-nv12
[247.163203] Starting dynamic subtest: pipe-A-eDP-1
[247.843653] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.681s)
[247.857678] Starting dynamic subtest: pipe-B-eDP-1
[249.199309] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.353s)
[249.216686] Starting dynamic subtest: pipe-C-eDP-1
[250.503535] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.301s)
[250.517844] Starting dynamic subtest: pipe-D-eDP-1
[251.799266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s)
[251.801785] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.638s)
[252.705654] [042/143] (750s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[252.764516] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[257.293350] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.531s)
[257.424497] [043/143] (745s left) kms_hdr (invalid-hdr)
[257.491260] Starting subtest: invalid-hdr
[258.606281] Starting dynamic subtest: pipe-A-eDP-1
[262.056160] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.451s)
[262.058958] Subtest invalid-hdr: SUCCESS (4.566s)
[262.147505] [044/143] (741s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[262.233640] Starting subtest: plane-all-transition-nonblocking-fencing
[262.236174] Starting dynamic subtest: pipe-A-eDP-1
[265.922628] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.691s)
[266.252082] Starting dynamic subtest: pipe-B-eDP-1
[269.634600] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.397s)
[269.954041] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.719s)
[270.883185] [045/143] (732s left) syncobj_timeline (signal)
[270.937218] Starting subtest: signal
[270.939554] Subtest signal: SUCCESS (0.000s)
[271.005711] [046/143] (732s left) kms_chamelium_hpd (vga-hpd)
[271.396751] Subtest vga-hpd: SKIP (0.000s)
[272.261765] [047/143] (731s left) gem_readwrite (new-obj)
[272.334072] Subtest new-obj: SKIP (0.000s)
[272.381223] [048/143] (731s left) kms_atomic_transition (plane-toggle-modeset-transition)
[272.470347] Starting subtest: plane-toggle-modeset-transition
[272.472823] Starting dynamic subtest: pipe-A-eDP-1
[287.032150] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.558s)
[287.053959] Starting dynamic subtest: pipe-B-eDP-1
[301.270947] Dynamic subtest pipe-B-eDP-1: SUCCESS (14.233s)
[301.274049] Subtest plane-toggle-modeset-transition: SUCCESS (28.801s)
[302.179858] [049/143] (701s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[302.239550] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[302.242019] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[302.305580] [050/143] (701s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[302.397281] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[302.401596] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[302.471700] [051/143] (701s left) kms_ccs (pipe-a-crc-primary-basic-yf-tiled-ccs)
[302.873109] Starting subtest: pipe-A-crc-primary-basic-yf-tiled-ccs
[302.878923] Subtest pipe-A-crc-primary-basic-yf-tiled-ccs: SKIP (0.000s)
[303.783823] [052/143] (699s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[303.829820] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[303.929899] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[304.006578] [053/143] (699s left) gem_softpin (evict-snoop-interruptible)
[304.073720] Starting subtest: evict-snoop-interruptible
[304.079582] Subtest evict-snoop-interruptible: SKIP (0.000s)
[304.148541] [054/143] (699s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[304.213853] Starting subtest: multi-wait-available-submitted-signaled
[304.216343] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[304.280371] [055/143] (699s left) kms_scaling_modes (scaling-mode-center)
[304.350680] Starting subtest: scaling-mode-center
[304.353192] Starting dynamic subtest: pipe-A-eDP-1
[304.443654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[304.460700] Starting dynamic subtest: pipe-B-eDP-1
[305.697390] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.250s)
[305.714818] Starting dynamic subtest: pipe-C-eDP-1
[306.965274] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.265s)
[306.973585] Starting dynamic subtest: pipe-D-eDP-1
[308.244608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.277s)
[308.246858] Subtest scaling-mode-center: SUCCESS (3.897s)
[309.536134] [056/143] (694s left) drm_mm (drm_mm)
[309.580960] Starting subtest: drm_mm
[309.716310] Starting dynamic subtest: drm_test_mm_init
[309.731766] Dynamic subtest drm_test_mm_init: SUCCESS (0.015s)
[309.746258] Starting dynamic subtest: drm_test_mm_debug
[309.748328] Dynamic subtest drm_test_mm_debug: SUCCESS (0.000s)
[309.757949] Starting dynamic subtest: drm_test_mm_reserve
[312.516798] Dynamic subtest drm_test_mm_reserve: SUCCESS (2.781s)
[312.534079] Starting dynamic subtest: drm_test_mm_insert
[320.771050] Dynamic subtest drm_test_mm_insert: SUCCESS (8.254s)
[320.776631] Starting dynamic subtest: drm_test_mm_replace
[320.778691] Dynamic subtest drm_test_mm_replace: SUCCESS (0.000s)
[320.784227] Starting dynamic subtest: drm_test_mm_insert_range
[323.902343] Dynamic subtest drm_test_mm_insert_range: SUCCESS (3.128s)
[323.912427] Starting dynamic subtest: drm_test_mm_frag
[323.941607] Dynamic subtest drm_test_mm_frag: SUCCESS (0.037s)
[323.954116] Starting dynamic subtest: drm_test_mm_align
[323.956059] Dynamic subtest drm_test_mm_align: SUCCESS (0.000s)
[323.962297] Starting dynamic subtest: drm_test_mm_align32
[323.964223] Dynamic subtest drm_test_mm_align32: SUCCESS (0.002s)
[323.970184] Starting dynamic subtest: drm_test_mm_align64
[323.972128] Dynamic subtest drm_test_mm_align64: SUCCESS (0.000s)
[323.977974] Starting dynamic subtest: drm_test_mm_evict
[324.629534] Dynamic subtest drm_test_mm_evict: SUCCESS (0.686s)
[324.636308] Starting dynamic subtest: drm_test_mm_evict_range
[324.638210] Dynamic subtest drm_test_mm_evict_range: SUCCESS (0.000s)
[324.644597] Starting dynamic subtest: drm_test_mm_topdown
[324.806164] Dynamic subtest drm_test_mm_topdown: SUCCESS (0.172s)
[324.812059] Starting dynamic subtest: drm_test_mm_bottomup
[324.814538] Dynamic subtest drm_test_mm_bottomup: SUCCESS (0.000s)
[324.820315] Starting dynamic subtest: drm_test_mm_lowest
[324.822598] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.000s)
[324.828271] Starting dynamic subtest: drm_test_mm_highest
[324.830502] Dynamic subtest drm_test_mm_highest: SUCCESS (0.000s)
[324.836323] Starting dynamic subtest: drm_test_mm_color
[325.345691] Dynamic subtest drm_test_mm_color: SUCCESS (0.535s)
[325.360358] Starting dynamic subtest: drm_test_mm_color_evict
[325.363062] Dynamic subtest drm_test_mm_color_evict: SUCCESS (0.000s)
[325.378543] Starting dynamic subtest: drm_test_mm_color_evict_range
[325.631911] Dynamic subtest drm_test_mm_color_evict_range: SUCCESS (0.284s)
[325.635676] Subtest drm_mm: SUCCESS (16.052s)
[325.817113] [057/143] (677s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[326.219324] Starting subtest: pipe-D-crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[326.225167] Subtest pipe-D-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[327.076133] [058/143] (676s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-mtl-mc-ccs)
[327.147632] Starting subtest: pipe-A-bad-pixel-format-4-tiled-mtl-mc-ccs
[327.152685] Subtest pipe-A-bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.001s)
[328.357029] [059/143] (675s left) v3d/v3d_wait_bo (unused-bo-0ns)
[328.422789] Subtest unused-bo-0ns: SKIP (0.000s)
[328.462640] [060/143] (675s left) kms_psr (pr-suspend)
[328.506501] Starting subtest: pr-suspend
[328.511651] Subtest pr-suspend: SKIP (0.000s)
[328.607874] [061/143] (675s left) gem_mmap_wc (write-gtt-read-wc)
[328.659683] Subtest write-gtt-read-wc: SKIP (0.000s)
[328.698566] [062/143] (675s left) api_intel_bb (blit-noreloc-purge-cache)
[328.751860] Starting subtest: blit-noreloc-purge-cache
[328.759792] Subtest blit-noreloc-purge-cache: SUCCESS (0.012s)
[328.859422] [063/143] (675s left) v3d/v3d_submit_cl (multisync-out-syncs)
[328.954383] Subtest multisync-out-syncs: SKIP (0.000s)
[329.007838] [064/143] (674s left) perf_pmu (init-wait)
[329.077799] Starting subtest: init-wait
[329.080337] Starting dynamic subtest: rcs0
[329.082762] Dynamic subtest rcs0: SUCCESS (0.002s)
[329.096398] Starting dynamic subtest: bcs0
[329.098695] Dynamic subtest bcs0: SUCCESS (0.001s)
[329.107750] Starting dynamic subtest: vcs0
[329.110161] Dynamic subtest vcs0: SUCCESS (0.001s)
[329.122102] Starting dynamic subtest: vcs1
[329.123980] Dynamic subtest vcs1: SUCCESS (0.001s)
[329.129820] Starting dynamic subtest: vecs0
[329.132122] Dynamic subtest vecs0: SUCCESS (0.001s)
[329.137944] Starting dynamic subtest: ccs0
[329.140221] Dynamic subtest ccs0: SUCCESS (0.001s)
[329.142420] Subtest init-wait: SUCCESS (0.013s)
[329.159835] [065/143] (674s left) prime_vgem (fence-flip-hang)
[329.252590] Subtest fence-flip-hang: SKIP (0.000s)
[329.341940] [066/143] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[329.416807] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[329.420622] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[329.488390] [067/143] (674s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[329.943134] Starting subtest: pipe-D-bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[329.949330] Subtest pipe-D-bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[330.789053] [068/143] (673s left) kms_cursor_edge_walk (64x64-left-edge)
[330.878994] Starting subtest: 64x64-left-edge
[330.881516] Starting dynamic subtest: pipe-A-eDP-1
[334.444527] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.567s)
[334.466099] Starting dynamic subtest: pipe-D-eDP-1
[337.688263] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.241s)
[337.690691] Subtest 64x64-left-edge: SUCCESS (6.813s)
[338.597154] [069/143] (665s left) gem_pxp (hw-rejects-pxp-context)
[341.177379] Starting subtest: hw-rejects-pxp-context
[341.180196] Subtest hw-rejects-pxp-context: SUCCESS (0.001s)
[341.252133] [070/143] (662s left) kms_ccs (pipe-a-bad-pixel-format-y-tiled-ccs)
[341.342785] Starting subtest: pipe-A-bad-pixel-format-y-tiled-ccs
[341.347483] Subtest pipe-A-bad-pixel-format-y-tiled-ccs: SKIP (0.000s)
[342.564315] [071/143] (661s left) kms_prop_blob (blob-prop-lifetime)
[342.630063] Starting subtest: blob-prop-lifetime
[342.632697] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[342.701278] [072/143] (661s left) perf (invalid-oa-metric-set-id)
[342.843701] Starting subtest: invalid-oa-metric-set-id
[342.853935] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[342.893149] [073/143] (661s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[343.284440] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[343.290659] Subtest pipe-C-crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[344.163558] [074/143] (660s left) prime_vgem (sync)
[344.230771] Starting subtest: sync
[344.232873] Starting dynamic subtest: rcs0
[344.274644] Dynamic subtest rcs0: SUCCESS (0.045s)
[344.289110] Starting dynamic subtest: bcs0
[344.330194] Dynamic subtest bcs0: SUCCESS (0.055s)
[344.341579] Starting dynamic subtest: vcs0
[344.387392] Dynamic subtest vcs0: SUCCESS (0.054s)
[344.399040] Starting dynamic subtest: vcs1
[344.439838] Dynamic subtest vcs1: SUCCESS (0.052s)
[344.452707] Starting dynamic subtest: vecs0
[344.492077] Dynamic subtest vecs0: SUCCESS (0.052s)
[344.501712] Starting dynamic subtest: ccs0
[344.544709] Dynamic subtest ccs0: SUCCESS (0.051s)
[344.549089] Subtest sync: SUCCESS (0.316s)
[344.641845] [075/143] (659s left) kms_big_fb (linear-8bpp-rotate-90)
[344.705787] Starting subtest: linear-8bpp-rotate-90
[344.725476] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[344.838191] [076/143] (659s left) kms_flip (2x-flip-vs-suspend)
[344.912134] Starting subtest: 2x-flip-vs-suspend
[344.928434] Subtest 2x-flip-vs-suspend: SKIP (0.019s)
[345.005143] [077/143] (659s left) perf_pmu (busy-check-all)
[345.073036] Starting subtest: busy-check-all
[345.075764] Starting dynamic subtest: rcs0
[345.631244] Dynamic subtest rcs0: SUCCESS (0.559s)
[345.649449] Starting dynamic subtest: bcs0
[346.188448] Dynamic subtest bcs0: SUCCESS (0.555s)
[346.206728] Starting dynamic subtest: vcs0
[347.430611] Dynamic subtest vcs0: SUCCESS (1.239s)
[347.449160] Starting dynamic subtest: vcs1
[349.414172] Dynamic subtest vcs1: SUCCESS (1.982s)
[349.432408] Starting dynamic subtest: vecs0
[351.462687] Dynamic subtest vecs0: SUCCESS (2.046s)
[351.480863] Starting dynamic subtest: ccs0
[352.023046] Dynamic subtest ccs0: SUCCESS (0.560s)
[352.026308] Subtest busy-check-all: SUCCESS (6.952s)
[352.102899] [078/143] (652s left) sw_sync (sync_busy)
[352.158076] Starting subtest: sync_busy
[352.160541] Subtest sync_busy: SUCCESS (0.001s)
[352.213666] [079/143] (652s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[352.287659] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[354.981912] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (2.697s)
[355.089399] [080/143] (649s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[355.164044] Starting subtest: 4-tiled-addfb-size-offset-overflow
[355.166089] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[355.249954] [081/143] (649s left) fbdev (unaligned-write)
[355.314698] Starting subtest: unaligned-write
[355.431045] Subtest unaligned-write: SUCCESS (0.115s)
[355.488245] [082/143] (649s left) i915_query (query-regions-unallocated)
[355.560491] Starting subtest: query-regions-unallocated
[355.563103] Subtest query-regions-unallocated: SUCCESS (0.000s)
[355.628096] [083/143] (648s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[355.732663] Starting subtest: 2x-long-flip-vs-cursor-legacy
[355.737621] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[355.866663] [084/143] (648s left) syncobj_basic (illegal-fd-to-handle)
[355.909871] Starting subtest: illegal-fd-to-handle
[355.911834] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[355.977316] [085/143] (648s left) kms_lease (lease-invalid-connector)
[356.045029] Starting subtest: lease-invalid-connector
[356.047493] Starting dynamic subtest: pipe-A-eDP-1
[356.049867] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[356.061105] Starting dynamic subtest: pipe-B-eDP-1
[356.063318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[356.069915] Starting dynamic subtest: pipe-C-eDP-1
[356.072043] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[356.081767] Starting dynamic subtest: pipe-D-eDP-1
[356.084245] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[356.086649] Subtest lease-invalid-connector: SUCCESS (0.003s)
[356.103913] [086/143] (648s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[356.186159] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[356.188629] Starting dynamic subtest: pipe-A-eDP-1
[356.193461] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[356.210874] Starting dynamic subtest: pipe-B-eDP-1
[356.215748] Dynamic subtest pipe-B-eDP-1: SKIP (0.012s)
[356.229278] Starting dynamic subtest: pipe-C-eDP-1
[356.233912] Dynamic subtest pipe-C-eDP-1: SKIP (0.012s)
[356.244453] Starting dynamic subtest: pipe-D-eDP-1
[356.248982] Dynamic subtest pipe-D-eDP-1: SKIP (0.012s)
[356.253454] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.043s)
[356.316430] [087/143] (648s left) gem_mmap_gtt (ptrace)
[356.361539] Subtest ptrace: SKIP (0.000s)
[356.389956] [088/143] (648s left) syncobj_timeline (wait-all-for-submit-complex)
[356.434685] Starting subtest: wait-all-for-submit-complex
[356.647863] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[356.724912] [089/143] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[356.806655] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[356.810938] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[356.889558] [090/143] (647s left) drm_fdinfo (context-close-stress)
[356.946586] Starting subtest: context-close-stress
[356.951033] Subtest context-close-stress: SKIP (0.000s)
[357.019198] [091/143] (647s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[357.128078] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[358.086633] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.959s)
[358.263238] [092/143] (646s left) gem_exec_reloc (basic-cpu-gtt)
[358.338311] Subtest basic-cpu-gtt: SKIP (0.000s)
[358.394932] [093/143] (646s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[358.455975] Subtest no-spare-fences-busy: SKIP (0.000s)
[358.484959] [094/143] (646s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-ccs)
[358.905280] Starting subtest: pipe-C-bad-aux-stride-y-tiled-ccs
[358.910185] Subtest pipe-C-bad-aux-stride-y-tiled-ccs: SKIP (0.000s)
[359.780993] [095/143] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[359.872246] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[359.876258] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[359.973645] [096/143] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[360.030592] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[364.571052] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.543s)
[364.706631] [097/143] (640s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[364.804571] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[367.560296] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.761s)
[367.696974] [098/143] (637s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[367.792258] Starting subtest: fbc-pr-cursor-mmap-gtt
[367.796258] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[367.922600] [099/143] (637s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-dg2-rc-ccs)
[368.302408] Starting subtest: pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs
[368.311718] Subtest pipe-A-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[369.187114] [100/143] (635s left) i915_pm_rpm (system-suspend)
[370.714950] Starting subtest: system-suspend
[393.991165] Subtest system-suspend: SUCCESS (8.277s)
[394.799345] [101/143] (625s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[396.617386] Starting subtest: modeset-lpsp-stress-no-wait
[408.199559] Subtest modeset-lpsp-stress-no-wait: SUCCESS (11.580s)
[408.284806] [102/143] (611s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[408.408924] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[409.021702] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.614s)
[409.188642] [103/143] (611s left) kms_flip (2x-plain-flip-interruptible)
[409.247965] Starting subtest: 2x-plain-flip-interruptible
[409.264496] Subtest 2x-plain-flip-interruptible: SKIP (0.013s)
[409.332960] [104/143] (610s left) kms_plane_scaling (planes-upscale-factor-0-25)
[409.393734] Starting subtest: planes-upscale-factor-0-25
[409.396236] Starting dynamic subtest: pipe-A-eDP-1
[409.455348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[409.473342] Starting dynamic subtest: pipe-B-eDP-1
[410.679773] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.222s)
[410.699507] Starting dynamic subtest: pipe-C-eDP-1
[411.882850] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s)
[411.903001] Starting dynamic subtest: pipe-D-eDP-1
[413.100311] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[413.102814] Subtest planes-upscale-factor-0-25: SUCCESS (3.709s)
[414.328125] [105/143] (605s left) sysfs_timeslice_duration (timeout)
[414.391176] Starting subtest: timeout
[414.393577] Starting dynamic subtest: vecs0
[424.434795] Dynamic subtest vecs0: SUCCESS (10.039s)
[424.458386] Starting dynamic subtest: ccs0
[425.134497] Dynamic subtest ccs0: SUCCESS (0.702s)
[425.154874] Starting dynamic subtest: vcs0
[434.420588] Dynamic subtest vcs0: SUCCESS (9.279s)
[434.441426] Starting dynamic subtest: bcs0
[435.039669] Dynamic subtest bcs0: SUCCESS (0.620s)
[435.059359] Starting dynamic subtest: rcs0
[435.714943] Dynamic subtest rcs0: SUCCESS (0.673s)
[435.736803] Starting dynamic subtest: vcs1
[445.366517] Dynamic subtest vcs1: SUCCESS (9.650s)
[445.369048] Subtest timeout: SUCCESS (30.973s)
[445.436398] [106/143] (574s left) vgem_basic (unload)
[445.487615] Starting subtest: unload
[474.446792] Subtest unload: SUCCESS (28.961s)
[474.561962] [107/143] (545s left) kms_async_flips (crc)
[474.626351] Starting subtest: crc
[474.995127] Starting dynamic subtest: pipe-A-eDP-1
[477.864815] Dynamic subtest pipe-A-eDP-1: FAIL (2.720s)
[478.129290] Starting dynamic subtest: pipe-B-eDP-1
[484.921918] Dynamic subtest pipe-B-eDP-1: FAIL (6.671s)
[485.183858] Starting dynamic subtest: pipe-C-eDP-1
[493.473140] Dynamic subtest pipe-C-eDP-1: FAIL (8.153s)
[493.736576] Starting dynamic subtest: pipe-D-eDP-1
[497.187692] Dynamic subtest pipe-D-eDP-1: FAIL (3.320s)
[497.189736] Subtest crc: FAIL (22.414s)
[499.898876] [108/143] (520s left) gem_exec_fence (syncobj-timeline-unused-fence)
[500.460331] Starting subtest: syncobj-timeline-unused-fence
[500.467354] Subtest syncobj-timeline-unused-fence: SUCCESS (0.009s)
[501.518962] [109/143] (518s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[501.616348] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[501.621074] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[501.702521] [110/143] (518s left) gem_exec_fence (basic-busy)
[501.903355] Starting subtest: basic-busy
[501.906029] Starting dynamic subtest: rcs0
[501.976230] Dynamic subtest rcs0: SUCCESS (0.073s)
[501.997396] Starting dynamic subtest: bcs0
[502.038232] Dynamic subtest bcs0: SUCCESS (0.061s)
[502.057852] Starting dynamic subtest: vcs0
[502.089229] Dynamic subtest vcs0: SUCCESS (0.049s)
[502.108005] Starting dynamic subtest: vcs1
[502.153885] Dynamic subtest vcs1: SUCCESS (0.063s)
[502.173273] Starting dynamic subtest: vecs0
[502.215803] Dynamic subtest vecs0: SUCCESS (0.061s)
[502.235239] Starting dynamic subtest: ccs0
[502.275972] Dynamic subtest ccs0: SUCCESS (0.058s)
[502.278597] Subtest basic-busy: SUCCESS (0.374s)
[504.515361] [111/143] (515s left) kms_ccs (pipe-d-missing-ccs-buffer-y-tiled-ccs)
[504.929920] Starting subtest: pipe-D-missing-ccs-buffer-y-tiled-ccs
[504.935353] Subtest pipe-D-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[505.755319] [112/143] (514s left) gem_mmap_wc (coherency)
[505.807873] Subtest coherency: SKIP (0.000s)
[505.846982] [113/143] (514s left) kms_vblank (wait-forked-busy-hang)
[505.942854] Starting subtest: wait-forked-busy-hang
[505.945350] Starting dynamic subtest: pipe-A-eDP-1
[520.355066] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.408s)
[520.379416] Starting dynamic subtest: pipe-D-eDP-1
[545.380990] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s)
[545.383885] Subtest wait-forked-busy-hang: SUCCESS (39.441s)
[546.302435] [114/143] (474s left) kms_flip (absolute-wf_vblank)
[546.358843] Starting subtest: absolute-wf_vblank
[546.360888] Starting dynamic subtest: A-eDP1
[555.172840] Dynamic subtest A-eDP1: SUCCESS (8.815s)
[555.193329] Starting dynamic subtest: B-eDP1
[564.066940] Dynamic subtest B-eDP1: SUCCESS (8.892s)
[564.091716] Starting dynamic subtest: C-eDP1
[572.965162] Dynamic subtest C-eDP1: SUCCESS (8.895s)
[572.985790] Starting dynamic subtest: D-eDP1
[581.861462] Dynamic subtest D-eDP1: SUCCESS (8.894s)
[581.870054] Subtest absolute-wf_vblank: SUCCESS (35.515s)
[583.167996] [115/143] (437s left) syncobj_wait (single-wait-submitted)
[583.232461] Starting subtest: single-wait-submitted
[583.337143] Subtest single-wait-submitted: SUCCESS (0.104s)
[583.405225] [116/143] (437s left) kms_sequence (queue-busy)
[583.479332] Starting subtest: queue-busy
[583.481991] Starting dynamic subtest: pipe-A-eDP-1
[585.440734] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.959s)
[585.460860] Starting dynamic subtest: pipe-B-eDP-1
[588.135447] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.693s)
[588.156873] Starting dynamic subtest: pipe-C-eDP-1
[590.820851] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.679s)
[590.839685] Starting dynamic subtest: pipe-D-eDP-1
[593.524777] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.703s)
[593.527510] Subtest queue-busy: SUCCESS (10.046s)
[594.433760] [117/143] (426s left) sw_sync (sync_multi_consumer_producer)
[594.492085] Starting subtest: sync_multi_consumer_producer
[594.865666] Subtest sync_multi_consumer_producer: SUCCESS (0.374s)
[594.930574] [118/143] (425s left) kms_flip (plain-flip-fb-recreate)
[595.063124] Starting subtest: plain-flip-fb-recreate
[595.071157] Starting dynamic subtest: A-eDP1
[604.073308] Dynamic subtest A-eDP1: SUCCESS (9.002s)
[604.094257] Starting dynamic subtest: B-eDP1
[613.043001] Dynamic subtest B-eDP1: SUCCESS (8.968s)
[613.063071] Starting dynamic subtest: C-eDP1
[622.057771] Dynamic subtest C-eDP1: SUCCESS (9.013s)
[622.073927] Starting dynamic subtest: D-eDP1
[631.016961] Dynamic subtest D-eDP1: SUCCESS (8.957s)
[631.025995] Subtest plain-flip-fb-recreate: SUCCESS (35.966s)
[632.318004] [119/143] (388s left) gem_exec_params (dr1-dirt)
[632.376083] Starting subtest: DR1-dirt
[632.378713] Subtest DR1-dirt: SUCCESS (0.000s)
[632.467771] [120/143] (388s left) kms_chamelium_color (ctm-red-to-blue)
[632.556226] Subtest ctm-red-to-blue: SKIP (0.000s)
[632.589021] [121/143] (388s left) gem_exec_capture (pi)
[632.660803] Starting subtest: pi
[632.663051] Starting dynamic subtest: rcs0
[637.067242] Dynamic subtest rcs0: SUCCESS (4.406s)
[637.087834] Starting dynamic subtest: bcs0
[641.167985] Dynamic subtest bcs0: SUCCESS (4.103s)
[641.183468] Starting dynamic subtest: vcs0
[645.213157] Dynamic subtest vcs0: SUCCESS (4.044s)
[645.230405] Starting dynamic subtest: vcs1
[649.316698] Dynamic subtest vcs1: SUCCESS (4.103s)
[649.331442] Starting dynamic subtest: vecs0
[653.465496] Dynamic subtest vecs0: SUCCESS (4.147s)
[653.478101] Starting dynamic subtest: ccs0
[657.549577] Dynamic subtest ccs0: SUCCESS (4.081s)
[657.552567] Subtest pi: SUCCESS (24.893s)
[657.633944] [122/143] (363s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[657.789407] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[657.793914] Starting dynamic subtest: A-eDP1
[661.761920] Dynamic subtest A-eDP1: SUCCESS (3.972s)
[661.782695] Starting dynamic subtest: B-eDP1
[665.216211] Dynamic subtest B-eDP1: SUCCESS (3.454s)
[665.238845] Starting dynamic subtest: C-eDP1
[668.654538] Dynamic subtest C-eDP1: SUCCESS (3.433s)
[668.671336] Starting dynamic subtest: D-eDP1
[672.111584] Dynamic subtest D-eDP1: SUCCESS (3.454s)
[672.115478] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (14.329s)
[672.998008] [123/143] (347s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[673.064715] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[673.068983] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[673.151551] [124/143] (347s left) vgem_basic (dmabuf-fence-before)
[673.212836] Starting subtest: dmabuf-fence-before
[673.215302] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[673.269492] [125/143] (347s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[673.625418] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[674.530228] [126/143] (346s left) gem_ringfill (engines-basic)
[680.448744] Starting subtest: engines-basic
[680.451377] Starting dynamic subtest: rcs0
[680.507840] Dynamic subtest rcs0: SUCCESS (0.059s)
[680.528976] Starting dynamic subtest: bcs0
[680.555767] Dynamic subtest bcs0: SUCCESS (0.047s)
[680.575054] Starting dynamic subtest: vcs0
[680.601915] Dynamic subtest vcs0: SUCCESS (0.044s)
[680.620885] Starting dynamic subtest: vcs1
[680.649338] Dynamic subtest vcs1: SUCCESS (0.046s)
[680.671039] Starting dynamic subtest: vecs0
[680.694899] Dynamic subtest vecs0: SUCCESS (0.044s)
[680.714498] Starting dynamic subtest: ccs0
[680.744699] Dynamic subtest ccs0: SUCCESS (0.048s)
[680.747590] Subtest engines-basic: SUCCESS (0.298s)
[680.827887] [127/143] (340s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[680.907834] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[680.910402] Starting dynamic subtest: pipe-A-default-mode
[683.770401] Dynamic subtest pipe-A-default-mode: SUCCESS (2.860s)
[683.772857] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.865s)
[684.669821] [128/143] (336s left) gem_ctx_param (vm)
[684.749836] Starting subtest: vm
[684.825210] Subtest vm: SUCCESS (0.079s)
[684.942233] [129/143] (336s left) vc4/vc4_wait_bo (bad-bo)
[685.029294] Subtest bad-bo: SKIP (0.000s)
[685.080254] [130/143] (335s left) kms_psr (fbc-psr2-cursor-plane-move)
[685.143752] Starting subtest: fbc-psr2-cursor-plane-move
[685.146378] Starting dynamic subtest: eDP-1
[685.151346] Dynamic subtest eDP-1: SKIP (0.000s)
[685.156150] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[685.258399] [131/143] (335s left) gem_exec_schedule (preempt-self)
[685.348978] Starting subtest: preempt-self
[685.351369] Starting dynamic subtest: rcs0
[685.400790] Dynamic subtest rcs0: SUCCESS (0.053s)
[685.422081] Starting dynamic subtest: bcs0
[685.453649] Dynamic subtest bcs0: SUCCESS (0.052s)
[685.477771] Starting dynamic subtest: vcs0
[685.504880] Dynamic subtest vcs0: SUCCESS (0.050s)
[685.526409] Starting dynamic subtest: vcs1
[685.554828] Dynamic subtest vcs1: SUCCESS (0.049s)
[685.574742] Starting dynamic subtest: vecs0
[685.599840] Dynamic subtest vecs0: SUCCESS (0.045s)
[685.609245] Starting dynamic subtest: ccs0
[685.643141] Dynamic subtest ccs0: SUCCESS (0.042s)
[685.645250] Subtest preempt-self: SUCCESS (0.297s)
[687.501894] [132/143] (333s left) kms_rotation_crc (primary-rotation-270)
[687.597095] Starting subtest: primary-rotation-270
[687.601955] Subtest primary-rotation-270: SKIP (0.001s)
[687.672934] [133/143] (333s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-mtl-mc-ccs)
[688.095156] Starting subtest: pipe-C-bad-pixel-format-4-tiled-mtl-mc-ccs
[688.098358] Subtest pipe-C-bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.001s)
[688.958346] [134/143] (332s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[689.044501] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[694.192013] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (5.148s)
[694.313830] [135/143] (326s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[694.397319] Starting subtest: plane-primary-toggle-with-vblank-wait
[694.399802] Starting dynamic subtest: pipe-A-eDP-1
[694.572685] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.176s)
[694.894484] Starting dynamic subtest: pipe-B-eDP-1
[695.877128] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.002s)
[696.190250] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.791s)
[697.084957] [136/143] (324s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[697.171387] Starting subtest: psr-modesetfrombusy
[701.452064] Subtest psr-modesetfrombusy: SUCCESS (4.284s)
[701.576507] [137/143] (319s left) api_intel_bb (simple-bb-ctx)
[701.633699] Starting subtest: simple-bb-ctx
[701.649370] Subtest simple-bb-ctx: SUCCESS (0.017s)
[701.761655] [138/143] (319s left) kms_cursor_crc (cursor-onscreen-128x128)
[701.924096] Starting subtest: cursor-onscreen-128x128
[701.926306] Starting dynamic subtest: pipe-A-eDP-1
[704.218716] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.289s)
[704.256526] Starting dynamic subtest: pipe-D-eDP-1
[707.425878] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.186s)
[707.428406] Subtest cursor-onscreen-128x128: SUCCESS (5.501s)
[708.313002] [139/143] (313s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[708.603717] Starting subtest: cursor-rapid-movement-512x170
[708.608664] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[708.757488] [140/143] (312s left) kms_psr (psr2-sprite-plane-move)
[708.824318] Starting subtest: psr2-sprite-plane-move
[708.826750] Starting dynamic subtest: eDP-1
[710.662001] Dynamic subtest eDP-1: SUCCESS (1.838s)
[710.664685] Subtest psr2-sprite-plane-move: SUCCESS (1.839s)
[711.550010] [141/143] (309s left) gen7_exec_parse (basic-offset)
[711.614852] Subtest basic-offset: SKIP (0.000s)
[711.654417] [142/143] (309s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[711.724539] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[711.728420] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[711.818703] [143/143] (309s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[711.898886] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[711.901259] Starting dynamic subtest: pipe-A-eDP-1
[711.965046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.067s)
[712.286481] Starting dynamic subtest: pipe-B-eDP-1
[713.120002] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.849s)
[713.432015] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.533s)
[714.360991] Closing watchdogs
Done.