[49.227506] Initializing watchdogs
[49.227841]   /dev/watchdog0
[49.244103] [001/142] (960s left) gem_exec_reloc (basic-write-gtt-active)
[49.520754] Starting subtest: basic-write-gtt-active
[49.694180] Subtest basic-write-gtt-active: SUCCESS (0.171s)
[49.950678] [002/142] (959s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[50.488248] Starting subtest: x-tiled-8bpp-rotate-180
[53.798770] Subtest x-tiled-8bpp-rotate-180: SUCCESS (3.309s)
[54.034443] [003/142] (955s left) kms_flip (flip-vs-blocking-wf-vblank)
[54.316170] Starting subtest: flip-vs-blocking-wf-vblank
[54.317675] Starting dynamic subtest: A-DP1
[65.140149] Dynamic subtest A-DP1: SUCCESS (10.824s)
[65.154491] Starting dynamic subtest: B-DP1
[75.932173] Dynamic subtest B-DP1: SUCCESS (10.791s)
[75.945975] Starting dynamic subtest: C-DP1
[86.673657] Dynamic subtest C-DP1: SUCCESS (10.740s)
[86.675106] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.364s)
[87.093090] [004/142] (922s left) v3d/v3d_create_bo (create-bo-4096)
[87.356186] Subtest create-bo-4096: SKIP (0.000s)
[87.422751] [005/142] (922s left) kms_vblank (pipe-c-query-idle)
[87.725177] Starting subtest: pipe-C-query-idle
[90.534137] Subtest pipe-C-query-idle: SUCCESS (2.808s)
[90.853347] [006/142] (919s left) v3d/v3d_wait_bo (unused-bo-0ns)
[91.102680] Subtest unused-bo-0ns: SKIP (0.000s)
[91.170508] [007/142] (918s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[91.479710] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[91.482365] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[91.569537] [008/142] (918s left) syncobj_wait (wait-any-complex)
[91.773864] Starting subtest: wait-any-complex
[91.838407] Subtest wait-any-complex: SUCCESS (0.064s)
[91.919251] [009/142] (918s left) kms_color (ctm-0-25)
[92.223107] Starting subtest: ctm-0-25
[92.224688] Starting dynamic subtest: pipe-A
[94.095468] Dynamic subtest pipe-A: SUCCESS (1.875s)
[94.112380] Starting dynamic subtest: pipe-B
[96.249558] Dynamic subtest pipe-B: SUCCESS (2.152s)
[96.268778] Starting dynamic subtest: pipe-C
[98.529295] Dynamic subtest pipe-C: SUCCESS (2.280s)
[98.530776] Subtest ctm-0-25: SUCCESS (6.308s)
[98.868828] [010/142] (911s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[99.181777] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[99.184369] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[99.285115] [011/142] (910s left) kms_psr (psr2_cursor_mmap_gtt)
[99.487471] Subtest psr2_cursor_mmap_gtt: SKIP (0.000s)
[99.534245] [012/142] (910s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[99.838165] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[99.840902] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[99.935520] [013/142] (910s left) kms_big_fb (linear-8bpp-rotate-90)
[100.259524] Starting subtest: linear-8bpp-rotate-90
[100.340364] Subtest linear-8bpp-rotate-90: SKIP (0.080s)
[100.452457] [014/142] (909s left) kms_draw_crc (draw-method-render)
[100.749361] Starting subtest: draw-method-render
[100.750647] Starting dynamic subtest: xrgb8888-untiled
[101.099533] Dynamic subtest xrgb8888-untiled: SUCCESS (0.351s)
[101.122434] Starting dynamic subtest: rgb565-untiled
[101.434682] Dynamic subtest rgb565-untiled: SUCCESS (0.334s)
[101.453442] Starting dynamic subtest: xrgb2101010-untiled
[101.803138] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.365s)
[101.829612] Starting dynamic subtest: xrgb8888-xtiled
[102.016137] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.216s)
[102.030996] Starting dynamic subtest: rgb565-xtiled
[102.217974] Dynamic subtest rgb565-xtiled: SUCCESS (0.199s)
[102.239258] Starting dynamic subtest: xrgb2101010-xtiled
[102.433943] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.216s)
[102.448220] Starting dynamic subtest: xrgb8888-ytiled
[102.650627] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.216s)
[102.665912] Starting dynamic subtest: rgb565-ytiled
[102.832646] Dynamic subtest rgb565-ytiled: SUCCESS (0.183s)
[102.847163] Starting dynamic subtest: xrgb2101010-ytiled
[103.033772] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.200s)
[103.035431] Subtest draw-method-render: SUCCESS (2.285s)
[103.136060] [015/142] (907s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[103.440786] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[103.442397] Starting dynamic subtest: pipe-A-valid-mode
[104.145634] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.703s)
[104.147062] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.705s)
[104.486616] [016/142] (905s left) api_intel_allocator (open-vm)
[104.688713] Starting subtest: open-vm
[104.693651] Subtest open-vm: SUCCESS (0.006s)
[104.803082] [017/142] (905s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[105.005932] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[105.007527] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[105.086444] [018/142] (905s left) gem_unref_active_buffers
[105.536049] [019/142] (904s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[105.855597] Starting subtest: yf-tiled-8bpp-rotate-90
[105.858446] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[105.953073] [020/142] (904s left) gen9_exec_parse (basic-rejected-ctx-param)
[106.182600] Starting subtest: basic-rejected-ctx-param
[106.260406] Subtest basic-rejected-ctx-param: SUCCESS (0.079s)
[106.470490] [021/142] (903s left) i915_pm_rps (thresholds-park)
[106.681414] Starting subtest: thresholds-park
[106.682835] Starting dynamic subtest: gt0
[106.687694] Dynamic subtest gt0: SKIP (0.004s)
[106.690422] Subtest thresholds-park: SKIP (0.005s)
[106.786456] [022/142] (903s left) kms_vblank (pipe-d-ts-continuation-modeset-hang)
[107.090775] Subtest pipe-D-ts-continuation-modeset-hang: SKIP (0.000s)
[107.170283] [023/142] (903s left) kms_busy (extended-pageflip-hang-newfb)
[107.475381] Starting subtest: extended-pageflip-hang-newfb
[107.476829] Starting dynamic subtest: pipe-A
[111.017343] Dynamic subtest pipe-A: SUCCESS (3.540s)
[111.035455] Starting dynamic subtest: pipe-C
[115.038047] Dynamic subtest pipe-C: SUCCESS (4.017s)
[115.039579] Subtest extended-pageflip-hang-newfb: SUCCESS (7.567s)
[115.414214] [024/142] (895s left) syncobj_wait (reset-signaled)
[115.616414] Starting subtest: reset-signaled
[115.618255] Subtest reset-signaled: SUCCESS (0.001s)
[115.695085] [025/142] (894s left) syncobj_wait (single-wait-signaled)
[115.895339] Starting subtest: single-wait-signaled
[115.897263] Subtest single-wait-signaled: SUCCESS (0.001s)
[115.979108] [026/142] (894s left) gem_userptr_blits (create-destroy-sync)
[116.220195] Starting subtest: create-destroy-sync
[121.268526] Subtest create-destroy-sync: SUCCESS (5.046s)
[121.395188] [027/142] (889s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[121.682286] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[121.688067] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.003s)
[121.796041] [028/142] (888s left) gem_exec_schedule (semaphore-noskip)
[122.033960] Starting subtest: semaphore-noskip
[122.288033] Subtest semaphore-noskip: SUCCESS (0.253s)
[122.645899] [029/142] (888s left) perf_pmu (gt-awake)
[122.858349] Starting subtest: gt-awake
[125.419465] Subtest gt-awake: SUCCESS (2.559s)
[125.529200] [030/142] (885s left) kms_ccs (pipe-d-crc-primary-basic-yf_tiled_ccs)
[126.198184] Subtest pipe-D-crc-primary-basic-yf_tiled_ccs: SKIP (0.000s)
[126.507912] [031/142] (884s left) gem_mmap_gtt (cpuset-basic-small-copy)
[126.708435] Starting subtest: cpuset-basic-small-copy
[133.180138] Subtest cpuset-basic-small-copy: SUCCESS (6.467s)
[133.276384] [032/142] (877s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[133.620753] Starting subtest: multi-wait-all-for-submit-signaled
[133.622550] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[133.706407] [033/142] (877s left) perf (oa-formats)
[134.054363] Starting subtest: oa-formats
[134.056055] Starting dynamic subtest: 0-rcs0
[134.255521] Dynamic subtest 0-rcs0: SUCCESS (0.201s)
[134.257035] Subtest oa-formats: SUCCESS (0.202s)
[134.306183] [034/142] (876s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[134.876828] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[134.883309] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.005s)
[135.324137] [035/142] (875s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[135.929338] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[135.931894] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[136.313811] [036/142] (874s left) kms_concurrent (pipe-c)
[136.619667] Starting subtest: pipe-C
[136.622933] Starting dynamic subtest: DP-1
[137.488874] Dynamic subtest DP-1: SUCCESS (0.865s)
[137.490326] Subtest pipe-C: SUCCESS (0.870s)
[137.807140] [037/142] (873s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs)
[138.200787] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs
[138.833766] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SUCCESS (0.631s)
[139.580294] [038/142] (871s left) kms_vblank (pipe-c-ts-continuation-dpms-suspend)
[139.881387] Starting subtest: pipe-C-ts-continuation-dpms-suspend
[158.071834] Subtest pipe-C-ts-continuation-dpms-suspend: SUCCESS (2.109s)
[163.878752] [039/142] (868s left) kms_getfb (getfb2-handle-closed)
[164.099789] Starting subtest: getfb2-handle-closed
[164.101291] Subtest getfb2-handle-closed: SUCCESS (0.001s)
[164.197295] [040/142] (868s left) kms_plane_alpha_blend (alpha-basic)
[164.499644] Starting subtest: alpha-basic
[164.813989] Starting dynamic subtest: pipe-A-DP-1
[165.364245] Dynamic subtest pipe-A-DP-1: FAIL (0.195s)
[165.384473] Starting dynamic subtest: pipe-C-DP-1
[166.203905] Dynamic subtest pipe-C-DP-1: FAIL (0.737s)
[166.205285] Subtest alpha-basic: FAIL (1.333s)
[166.249891] [041/142] (866s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[166.911717] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[167.212443] [042/142] (865s left) vgem_basic (debugfs)
[167.487825] Starting subtest: debugfs
[167.489544] Subtest debugfs: SUCCESS (0.002s)
[167.562367] [043/142] (865s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[167.879724] Starting subtest: fbc-rgb101010-draw-pwrite
[170.552268] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.676s)
[170.679925] [044/142] (861s left) gem_exec_balancer (invalid-bonds)
[170.907532] Starting subtest: invalid-bonds
[170.924100] Subtest invalid-bonds: SUCCESS (0.016s)
[174.879680] [045/142] (857s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[175.184084] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[175.186626] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[175.279453] [046/142] (857s left) gem_mmap (pf-nonblock)
[175.478681] Starting subtest: pf-nonblock
[175.488297] Subtest pf-nonblock: SUCCESS (0.007s)
[175.595504] [047/142] (857s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[175.799942] Starting subtest: invalid-multi-wait-all-unsubmitted
[175.801766] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[175.895929] [048/142] (856s left) gem_mmap_gtt (basic-short)
[176.096353] Starting subtest: basic-short
[176.149295] Subtest basic-short: SUCCESS (0.053s)
[176.262033] [049/142] (856s left) kms_vblank (pipe-a-query-forked-busy-hang)
[176.558151] Starting subtest: pipe-A-query-forked-busy-hang
[183.981886] Subtest pipe-A-query-forked-busy-hang: SUCCESS (7.428s)
[184.327248] [050/142] (848s left) kms_ccs (pipe-a-crc-primary-basic-yf_tiled_ccs)
[184.728841] Starting subtest: pipe-A-crc-primary-basic-yf_tiled_ccs
[185.383018] Subtest pipe-A-crc-primary-basic-yf_tiled_ccs: SUCCESS (0.656s)
[186.040566] [051/142] (846s left) kms_addfb_basic (bad-pitch-256)
[186.243533] Starting subtest: bad-pitch-256
[186.245054] Subtest bad-pitch-256: SUCCESS (0.000s)
[186.437556] [052/142] (846s left) api_intel_bb (blit-noreloc-purge-cache)
[186.639079] Starting subtest: blit-noreloc-purge-cache
[186.658420] Subtest blit-noreloc-purge-cache: SUCCESS (0.019s)
[186.771303] [053/142] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[187.082876] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[187.085462] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[187.188420] [054/142] (845s left) kms_universal_plane (universal-plane-pipe-a-sanity)
[187.491538] Starting subtest: universal-plane-pipe-A-sanity
[187.908565] Subtest universal-plane-pipe-A-sanity: SUCCESS (0.420s)
[188.216648] [055/142] (844s left) dmabuf_sync_file (import-basic)
[188.424330] Starting subtest: import-basic
[188.432165] Subtest import-basic: SUCCESS (0.008s)
[188.499839] [056/142] (844s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[188.811135] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[190.906242] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.097s)
[191.051264] [057/142] (842s left) gem_exec_balancer (fairslice)
[191.277181] Starting subtest: fairslice
[191.280035] Subtest fairslice: SKIP (0.000s)
[195.235528] [058/142] (837s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[195.444395] Starting subtest: invalid-bsd1-flag-on-blt
[195.446499] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.001s)
[195.549893] [059/142] (837s left) kms_vblank (pipe-b-accuracy-idle)
[195.849187] Starting subtest: pipe-B-accuracy-idle
[198.514078] Subtest pipe-B-accuracy-idle: SUCCESS (2.667s)
[198.853414] [060/142] (834s left) gem_exec_whisper (basic-contexts-all)
[199.082644] Starting subtest: basic-contexts-all
[212.701637] Subtest basic-contexts-all: SUCCESS (13.618s)
[212.904863] [061/142] (820s left) kms_cursor_crc (cursor-sliding-256x85)
[213.224271] Starting subtest: cursor-sliding-256x85
[213.236686] Starting dynamic subtest: pipe-A-DP-1
[216.907088] Dynamic subtest pipe-A-DP-1: SUCCESS (3.671s)
[216.991213] Starting dynamic subtest: pipe-C-DP-1
[220.984354] Dynamic subtest pipe-C-DP-1: SUCCESS (4.013s)
[220.985564] Subtest cursor-sliding-256x85: SUCCESS (7.759s)
[221.341745] [062/142] (812s left) syncobj_timeline (reset-multiple-signaled)
[221.552029] Starting subtest: reset-multiple-signaled
[221.556030] Subtest reset-multiple-signaled: SUCCESS (0.002s)
[221.638155] [063/142] (811s left) kms_async_flips (async-flip-with-page-flip-events)
[221.976428] Starting subtest: async-flip-with-page-flip-events
[222.479377] Starting dynamic subtest: pipe-A-DP-1-Yf-CCS
[223.313925] Dynamic subtest pipe-A-DP-1-Yf-CCS: SKIP (0.834s)
[223.335801] Starting dynamic subtest: pipe-A-DP-1-Y-CCS
[223.908326] Dynamic subtest pipe-A-DP-1-Y-CCS: SKIP (0.595s)
[223.934008] Starting dynamic subtest: pipe-A-DP-1-Yf
[226.520288] Dynamic subtest pipe-A-DP-1-Yf: SUCCESS (2.611s)
[226.542928] Starting dynamic subtest: pipe-A-DP-1-Y
[229.156389] Dynamic subtest pipe-A-DP-1-Y: SUCCESS (2.631s)
[229.178965] Starting dynamic subtest: pipe-A-DP-1-X
[231.303791] Dynamic subtest pipe-A-DP-1-X: SUCCESS (2.147s)
[231.325607] Starting dynamic subtest: pipe-A-DP-1-linear
[231.471965] Dynamic subtest pipe-A-DP-1-linear: SKIP (0.166s)
[231.936392] Starting dynamic subtest: pipe-B-DP-1-Yf-CCS
[232.784553] Dynamic subtest pipe-B-DP-1-Yf-CCS: SKIP (0.865s)
[232.806739] Starting dynamic subtest: pipe-B-DP-1-Y-CCS
[233.394102] Dynamic subtest pipe-B-DP-1-Y-CCS: SKIP (0.607s)
[233.415916] Starting dynamic subtest: pipe-B-DP-1-Yf
[235.991424] Dynamic subtest pipe-B-DP-1-Yf: SUCCESS (2.596s)
[236.013281] Starting dynamic subtest: pipe-B-DP-1-Y
[238.606826] Dynamic subtest pipe-B-DP-1-Y: SUCCESS (2.614s)
[238.630318] Starting dynamic subtest: pipe-B-DP-1-X
[240.739699] Dynamic subtest pipe-B-DP-1-X: SUCCESS (2.130s)
[240.762191] Starting dynamic subtest: pipe-B-DP-1-linear
[240.880218] Dynamic subtest pipe-B-DP-1-linear: SKIP (0.138s)
[241.266344] Starting dynamic subtest: pipe-C-DP-1-Yf
[244.073522] Dynamic subtest pipe-C-DP-1-Yf: SUCCESS (2.826s)
[244.095938] Starting dynamic subtest: pipe-C-DP-1-Y
[246.685277] Dynamic subtest pipe-C-DP-1-Y: SUCCESS (2.610s)
[246.707870] Starting dynamic subtest: pipe-C-DP-1-X
[248.818293] Dynamic subtest pipe-C-DP-1-X: SUCCESS (2.130s)
[248.841142] Starting dynamic subtest: pipe-C-DP-1-linear
[248.970075] Dynamic subtest pipe-C-DP-1-linear: SKIP (0.149s)
[248.971540] Subtest async-flip-with-page-flip-events: SUCCESS (26.998s)
[249.537280] [064/142] (783s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[249.846311] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[249.849235] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[249.952749] [065/142] (783s left) i915_pm_rpm (modeset-non-lpsp)
[251.759314] Starting subtest: modeset-non-lpsp
[252.399245] Subtest modeset-non-lpsp: SUCCESS (0.632s)
[252.632203] [066/142] (780s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[252.887734] Subtest bad-multisync-out-sync: SKIP (0.000s)
[252.963540] [067/142] (780s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[253.463854] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[253.466833] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[253.956364] [068/142] (779s left) kms_atomic (plane-invalid-params)
[254.385426] Starting subtest: plane-invalid-params
[254.529402] Subtest plane-invalid-params: SUCCESS (0.144s)
[254.966281] [069/142] (778s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[255.271226] Starting subtest: universal-plane-pipe-B-sanity
[256.120250] Subtest universal-plane-pipe-B-sanity: SUCCESS (0.850s)
[256.440048] [070/142] (777s left) gem_exec_fence (keep-in-fence)
[256.802893] Starting subtest: keep-in-fence
[256.804372] Starting dynamic subtest: rcs0
[256.840572] Dynamic subtest rcs0: SUCCESS (0.037s)
[256.872217] Starting dynamic subtest: bcs0
[256.992014] Dynamic subtest bcs0: SUCCESS (0.149s)
[257.018754] Starting dynamic subtest: vcs0
[257.038531] Dynamic subtest vcs0: SUCCESS (0.044s)
[257.066371] Starting dynamic subtest: vecs0
[257.084068] Dynamic subtest vecs0: SUCCESS (0.044s)
[257.085330] Subtest keep-in-fence: SUCCESS (0.283s)
[257.757051] [071/142] (776s left) kms_vblank (pipe-d-query-forked-busy-hang)
[258.052405] Subtest pipe-D-query-forked-busy-hang: SKIP (0.000s)
[258.140343] [072/142] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[258.452029] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[258.455187] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[258.556282] [073/142] (775s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[258.875666] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[261.544469] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.669s)
[261.690163] [074/142] (772s left) dmabuf (all-tests)
[261.893739] Starting subtest: all-tests
[261.895143] Starting dynamic subtest: sanitycheck
[261.966309] Dynamic subtest sanitycheck: SUCCESS (0.071s)
[261.991519] Starting dynamic subtest: dma_fence
[262.158817] Dynamic subtest dma_fence: SUCCESS (0.189s)
[262.182452] Starting dynamic subtest: dma_fence_chain
[285.777027] Dynamic subtest dma_fence_chain: SUCCESS (23.616s)
[285.806880] Starting dynamic subtest: dma_fence_unwrap
[285.851662] Dynamic subtest dma_fence_unwrap: SUCCESS (0.072s)
[285.881881] Starting dynamic subtest: dma_resv
[285.920417] Dynamic subtest dma_resv: SUCCESS (0.066s)
[285.922343] Subtest all-tests: SUCCESS (24.029s)
[286.006196] [075/142] (747s left) gem_exec_reloc (basic-write-cpu-active)
[286.220432] Starting subtest: basic-write-cpu-active
[286.358848] Subtest basic-write-cpu-active: SUCCESS (0.137s)
[286.557078] [076/142] (747s left) perf (gen12-unprivileged-single-ctx-counters)
[286.850178] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[286.906830] [077/142] (747s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_mc_ccs)
[287.571858] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[287.893807] [078/142] (746s left) sw_sync (sync_random_merge)
[288.096630] Starting subtest: sync_random_merge
[288.244246] Subtest sync_random_merge: SUCCESS (0.149s)
[288.326108] [079/142] (745s left) gem_mmap_wc (set-cache-level)
[288.528518] Starting subtest: set-cache-level
[288.533489] Subtest set-cache-level: SUCCESS (0.003s)
[288.626311] [080/142] (745s left) gem_mmap_gtt (big-copy-xy)
[288.829510] Starting subtest: big-copy-XY
[301.234670] Subtest big-copy-XY: SUCCESS (12.405s)
[301.395051] [081/142] (732s left) gem_ctx_isolation (dirty-switch)
[301.746111] Starting subtest: dirty-switch
[301.747894] Starting dynamic subtest: rcs0
[303.413726] Dynamic subtest rcs0: SUCCESS (1.666s)
[303.435737] Starting dynamic subtest: bcs0
[305.579896] Dynamic subtest bcs0: SUCCESS (2.164s)
[305.603228] Starting dynamic subtest: vcs0
[307.182968] Dynamic subtest vcs0: SUCCESS (1.601s)
[307.205271] Starting dynamic subtest: vecs0
[308.787254] Dynamic subtest vecs0: SUCCESS (1.601s)
[308.789282] Subtest dirty-switch: SUCCESS (7.041s)
[308.999003] [082/142] (725s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[309.284737] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[309.359546] [083/142] (724s left) gem_tiled_blits (interruptible)
[309.775269] Starting subtest: interruptible
[362.752288] Subtest interruptible: SUCCESS (52.977s)
[362.881018] [084/142] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[363.317945] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[363.320727] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[363.427538] [085/142] (670s left) kms_cursor_edge_walk (64x64-right-edge)
[363.723656] Starting subtest: 64x64-right-edge
[363.725057] Starting dynamic subtest: pipe-A-DP-1
[367.539818] Dynamic subtest pipe-A-DP-1: SUCCESS (3.814s)
[367.565922] Starting dynamic subtest: pipe-C-DP-1
[371.021934] Dynamic subtest pipe-C-DP-1: SUCCESS (3.479s)
[371.023319] Subtest 64x64-right-edge: SUCCESS (7.303s)
[371.352362] [086/142] (663s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[371.671262] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[371.674262] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[371.785567] [087/142] (662s left) kms_chamelium_frames (dp-frame-dump)
[372.172163] Subtest dp-frame-dump: SKIP (0.000s)
[372.469421] [088/142] (662s left) gem_exec_parallel (engines)
[372.693971] Starting subtest: engines
[372.698769] Starting dynamic subtest: basic
[376.272461] Dynamic subtest basic: SUCCESS (3.576s)
[376.298489] Starting dynamic subtest: contexts
[380.274394] Dynamic subtest contexts: SUCCESS (3.998s)
[380.300686] Starting dynamic subtest: fds
[384.939550] Dynamic subtest fds: SUCCESS (4.662s)
[384.967512] Starting dynamic subtest: userptr
[388.636985] Dynamic subtest userptr: SUCCESS (3.693s)
[388.638456] Subtest engines: SUCCESS (15.944s)
[388.869726] [089/142] (645s left) kms_vblank (pipe-c-ts-continuation-modeset-rpm)
[389.175825] Starting subtest: pipe-C-ts-continuation-modeset-rpm
[391.523384] Subtest pipe-C-ts-continuation-modeset-rpm: SUCCESS (2.348s)
[392.013535] [090/142] (642s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs)
[392.448300] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs
[392.452255] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[393.061251] [091/142] (641s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted)
[393.283575] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted
[393.285169] Subtest invalid-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.002s)
[393.377992] [092/142] (641s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_ccs)
[394.059052] Subtest pipe-D-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[394.371193] [093/142] (640s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-75)
[394.671986] Starting subtest: plane-downscale-with-pixel-format-factor-0-75
[394.673305] Starting dynamic subtest: pipe-A-DP-1
[397.072836] Dynamic subtest pipe-A-DP-1: SUCCESS (2.401s)
[397.103235] Starting dynamic subtest: pipe-B-DP-1
[399.771683] Dynamic subtest pipe-B-DP-1: SUCCESS (2.691s)
[399.798711] Starting dynamic subtest: pipe-C-DP-1
[400.164738] Dynamic subtest pipe-C-DP-1: SUCCESS (0.387s)
[400.166173] Subtest plane-downscale-with-pixel-format-factor-0-75: SUCCESS (5.495s)
[400.562549] [094/142] (634s left) gem_exercise_blt (fast-copy)
[400.773522] Starting subtest: fast-copy
[400.775153] Starting dynamic subtest: linear-smem-smem
[400.836095] Dynamic subtest linear-smem-smem: SUCCESS (0.061s)
[400.865376] Starting dynamic subtest: ymajor-smem-smem
[400.890355] Dynamic subtest ymajor-smem-smem: SUCCESS (0.052s)
[400.920430] Starting dynamic subtest: yfmajor-smem-smem
[400.942545] Dynamic subtest yfmajor-smem-smem: SUCCESS (0.050s)
[400.973574] Starting dynamic subtest: tile64-smem-smem
[400.994518] Dynamic subtest tile64-smem-smem: SUCCESS (0.050s)
[400.996807] Subtest fast-copy: SUCCESS (0.222s)
[401.109124] [095/142] (633s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[401.674117] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[401.676800] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[402.102756] [096/142] (632s left) gem_ccs (block-copy-compressed)
[402.315920] Subtest block-copy-compressed: SKIP (0.000s)
[402.385405] [097/142] (632s left) gem_exec_fence (syncobj-invalid-wait)
[403.057474] Starting subtest: syncobj-invalid-wait
[403.062130] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[403.419946] [098/142] (631s left) kms_lease (lease_revoke)
[403.719441] Starting subtest: lease_revoke
[403.720769] Starting dynamic subtest: pipe-A-DP-1
[403.819892] Dynamic subtest pipe-A-DP-1: SUCCESS (0.101s)
[403.847911] Starting dynamic subtest: pipe-B-DP-1
[403.930888] Dynamic subtest pipe-B-DP-1: SUCCESS (0.105s)
[403.963720] Starting dynamic subtest: pipe-C-DP-1
[404.045535] Dynamic subtest pipe-C-DP-1: SUCCESS (0.107s)
[404.051032] Subtest lease_revoke: SUCCESS (0.330s)
[404.153026] [099/142] (630s left) template (a)
[404.356226] Starting subtest: A
[404.357553] Subtest A: SUCCESS (0.000s)
[404.453168] [100/142] (630s left) gem_ctx_persistence (legacy-engines-persistence)
[404.665116] Starting subtest: legacy-engines-persistence
[404.669468] Starting dynamic subtest: render
[405.428280] Dynamic subtest render: SUCCESS (0.760s)
[405.456392] Starting dynamic subtest: bsd
[406.201302] Dynamic subtest bsd: SUCCESS (0.770s)
[406.229362] Starting dynamic subtest: blt
[406.964302] Dynamic subtest blt: SUCCESS (0.759s)
[406.992662] Starting dynamic subtest: vebox
[407.737288] Dynamic subtest vebox: SUCCESS (0.769s)
[407.739099] Subtest legacy-engines-persistence: SUCCESS (3.074s)
[407.835560] [101/142] (627s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[408.145687] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[408.148443] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[408.252932] [102/142] (626s left) i915_pm_backlight (basic-brightness)
[408.547430] Subtest basic-brightness: SKIP (0.000s)
[408.603199] [103/142] (626s left) i915_pm_rpm (cursor-dpms)
[410.420501] Starting subtest: cursor-dpms
[413.436550] Subtest cursor-dpms: SUCCESS (3.016s)
[413.872788] [104/142] (621s left) kms_force_connector_basic (force-connector-state)
[414.075313] Subtest force-connector-state: SKIP (0.000s)
[414.135995] [105/142] (621s left) prime_vgem (basic-write)
[414.368123] Starting subtest: basic-write
[414.431499] Subtest basic-write: SUCCESS (0.063s)
[414.537238] [106/142] (620s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[414.876730] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[414.879716] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[414.987499] [107/142] (620s left) kms_vblank (pipe-b-query-forked-hang)
[415.291218] Starting subtest: pipe-B-query-forked-hang
[422.969163] Subtest pipe-B-query-forked-hang: SUCCESS (7.679s)
[423.324224] [108/142] (612s left) prime_mmap_coherency (ioctl-errors)
[423.536303] Starting subtest: ioctl-errors
[438.500240] Subtest ioctl-errors: SUCCESS (14.963s)
[438.623473] [109/142] (596s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[439.408435] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[439.414261] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.004s)
[439.751516] [110/142] (595s left) gen9_exec_parse (secure-batches)
[439.982844] Starting subtest: secure-batches
[439.984783] Subtest secure-batches: SUCCESS (0.000s)
[440.218134] [111/142] (595s left) prime_self_import (basic-llseek-size)
[440.415518] Starting subtest: basic-llseek-size
[440.422087] Subtest basic-llseek-size: SUCCESS (0.007s)
[440.534284] [112/142] (595s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[440.961028] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[440.963795] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[441.519136] [113/142] (594s left) kms_getfb (getfb-repeated-different-handles)
[441.725516] Starting subtest: getfb-repeated-different-handles
[441.727663] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[441.839560] [114/142] (593s left) fbdev (unaligned-read)
[442.056499] Starting subtest: unaligned-read
[442.069101] Subtest unaligned-read: SUCCESS (0.012s)
[442.151438] [115/142] (593s left) core_auth (basic-auth)
[442.352030] Starting subtest: basic-auth
[442.353831] Subtest basic-auth: SUCCESS (0.002s)
[442.451071] [116/142] (593s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[442.987075] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[442.992839] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[443.453862] [117/142] (592s left) syncobj_timeline (invalid-signal-zero-handles)
[443.675265] Starting subtest: invalid-signal-zero-handles
[443.677207] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[443.768842] [118/142] (592s left) gem_ctx_persistence (many-contexts)
[443.978340] Starting subtest: many-contexts
[476.793341] Subtest many-contexts: SUCCESS (32.813s)
[476.884760] [119/142] (559s left) kms_atomic_interruptible (universal-setplane-primary)
[477.189541] Starting subtest: universal-setplane-primary
[477.193871] Starting dynamic subtest: DP-1-pipe-A
[483.700065] Dynamic subtest DP-1-pipe-A: SUCCESS (6.506s)
[483.701663] Subtest universal-setplane-primary: SUCCESS (6.512s)
[484.063380] [120/142] (551s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[484.288239] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[484.292672] Starting dynamic subtest: smem
[484.719605] Dynamic subtest smem: SUCCESS (0.428s)
[484.722098] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.433s)
[484.929854] [121/142] (551s left) gem_userptr_blits (nohangcheck)
[485.207425] Starting subtest: nohangcheck
[485.528900] Subtest nohangcheck: SUCCESS (0.322s)
[485.645412] [122/142] (550s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[485.964183] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[485.967484] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[486.079466] [123/142] (550s left) kms_cursor_crc (cursor-offscreen-128x128)
[486.395276] Starting subtest: cursor-offscreen-128x128
[486.408246] Starting dynamic subtest: pipe-A-DP-1
[489.063465] Dynamic subtest pipe-A-DP-1: SUCCESS (2.654s)
[489.152493] Starting dynamic subtest: pipe-C-DP-1
[491.956350] Dynamic subtest pipe-C-DP-1: SUCCESS (2.828s)
[491.957983] Subtest cursor-offscreen-128x128: SUCCESS (5.563s)
[492.331805] [124/142] (543s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[492.556577] Starting subtest: y-tiled-to-vebox-y-tiled
[492.559681] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[492.762283] [125/142] (543s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[493.063429] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[493.064855] Starting dynamic subtest: pipe-A-DP-1
[493.094742] Dynamic subtest pipe-A-DP-1: SKIP (0.029s)
[493.122878] Starting dynamic subtest: pipe-B-DP-1
[493.179310] Dynamic subtest pipe-B-DP-1: SKIP (0.078s)
[493.207168] Starting dynamic subtest: pipe-C-DP-1
[493.262507] Dynamic subtest pipe-C-DP-1: SKIP (0.078s)
[493.265289] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.201s)
[493.378113] [126/142] (542s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[493.582951] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[493.690950] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[493.793818] [127/142] (542s left) kms_selftest (drm_dp_mst)
[493.989711] Starting subtest: drm_dp_mst
[493.995892] Subtest drm_dp_mst: SKIP (0.004s)
[494.079156] [128/142] (542s left) vgem_basic (busy-fence)
[494.297706] Starting subtest: busy-fence
[494.299501] Subtest busy-fence: SUCCESS (0.000s)
[494.378368] [129/142] (542s left) kms_content_protection (atomic)
[494.708424] Starting subtest: atomic
[494.749413] Starting dynamic subtest: pipe-A-DP-1
[615.657401] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[616.421146] Closing watchdogs
[616.424790] Initializing watchdogs
[616.424955]   /dev/watchdog0
[616.455290] [130/142] (420s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[616.763986] Starting subtest: cursorB-vs-flipA-atomic
[616.767363] Subtest cursorB-vs-flipA-atomic: SKIP (0.004s)
[616.861556] [131/142] (419s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[617.183993] Starting subtest: y-tiled-16bpp-rotate-270
[617.291172] Subtest y-tiled-16bpp-rotate-270: SKIP (0.106s)
[617.427878] [132/142] (419s left) gem_exec_schedule (pi-distinct-iova)
[617.792916] Starting subtest: pi-distinct-iova
[617.794513] Starting dynamic subtest: rcs0
[617.871786] Dynamic subtest rcs0: SUCCESS (0.077s)
[617.907001] Starting dynamic subtest: bcs0
[617.945389] Dynamic subtest bcs0: SUCCESS (0.072s)
[617.977050] Starting dynamic subtest: vcs0
[617.999365] Dynamic subtest vcs0: SUCCESS (0.050s)
[618.032197] Starting dynamic subtest: vecs0
[618.058101] Dynamic subtest vecs0: SUCCESS (0.055s)
[618.061223] Subtest pi-distinct-iova: SUCCESS (0.267s)
[618.295347] [133/142] (418s left) gem_caching (read-writes)
[618.505333] Starting subtest: read-writes
[644.831471] Subtest read-writes: SUCCESS (26.326s)
[644.992917] [134/142] (391s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[645.303311] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[645.304989] Starting dynamic subtest: pipe-A-valid-mode
[645.986962] Dynamic subtest pipe-A-valid-mode: SKIP (0.683s)
[645.989523] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.687s)
[646.399992] [135/142] (390s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[646.703177] Starting subtest: psr-rgb101010-draw-mmap-cpu
[646.706094] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[646.816207] [136/142] (389s left) gem_pxp (reject-modify-context-protection-off-3)
[649.538442] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[649.648077] [137/142] (387s left) kms_psr (primary_blt)
[649.855365] Subtest primary_blt: SKIP (0.000s)
[649.918069] [138/142] (386s left) kms_invalid_mode (uint-max-clock)
[650.216041] Starting subtest: uint-max-clock
[650.217534] Starting dynamic subtest: DP-1-pipe-A
[650.311063] Dynamic subtest DP-1-pipe-A: SUCCESS (0.094s)
[650.338119] Starting dynamic subtest: DP-1-pipe-B
[650.340296] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[650.368011] Starting dynamic subtest: DP-1-pipe-C
[650.370856] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[650.373213] Subtest uint-max-clock: SUCCESS (0.134s)
[650.676365] [139/142] (386s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[650.998330] Starting subtest: y-tiled-64bpp-rotate-0
[658.744973] Subtest y-tiled-64bpp-rotate-0: SUCCESS (7.748s)
[659.676995] [140/142] (377s left) kms_cdclk (plane-scaling)
[659.878437] Subtest plane-scaling: SKIP (0.000s)
[659.940071] [141/142] (377s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-sf)
[660.141920] Subtest cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[660.208210] [142/142] (376s left) v3d/v3d_mmap (mmap-bad-handle)
[660.462470] Subtest mmap-bad-handle: SKIP (0.000s)
[660.537866] Closing watchdogs
Done.