[39.586132] Initializing watchdogs
[39.586366]   /dev/watchdog0
[39.619068] [001/142] (960s left) gem_workarounds (reset-fd)
[39.952866] Starting subtest: reset-fd
[40.016549] Subtest reset-fd: SUCCESS (0.046s)
[40.137464] [002/142] (960s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[43.144066] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[43.269706] [003/142] (957s left) gen9_exec_parse (bb-oversize)
[43.573191] Starting subtest: bb-oversize
[44.842662] Subtest bb-oversize: SKIP (1.099s)
[44.967169] [004/142] (955s left) kms_vblank (pipe-b-ts-continuation-dpms-rpm)
[45.525204] Starting subtest: pipe-B-ts-continuation-dpms-rpm
[48.003786] Subtest pipe-B-ts-continuation-dpms-rpm: SUCCESS (2.475s)
[48.539657] [005/142] (951s left) gem_exec_balancer (bonded-dual)
[48.916093] Starting subtest: bonded-dual
[52.836501] Subtest bonded-dual: SUCCESS (3.762s)
[56.722433] [006/142] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[57.170547] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[57.210663] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[57.316050] [007/142] (943s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_mc_ccs)
[58.062951] Subtest pipe-D-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[58.388485] [008/142] (942s left) dmabuf (all-tests)
[58.707109] Starting subtest: all-tests
[58.725887] Starting dynamic subtest: sanitycheck
[58.764878] Dynamic subtest sanitycheck: SUCCESS (0.079s)
[58.806679] Starting dynamic subtest: dma_fence
[58.947234] Dynamic subtest dma_fence: SUCCESS (0.182s)
[58.979645] Starting dynamic subtest: dma_fence_chain
[83.217250] Dynamic subtest dma_fence_chain: SUCCESS (24.271s)
[83.251748] Starting dynamic subtest: dma_fence_unwrap
[83.293175] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s)
[83.331083] Starting dynamic subtest: dma_resv
[83.374560] Dynamic subtest dma_resv: SUCCESS (0.073s)
[83.393456] Subtest all-tests: SUCCESS (24.680s)
[83.474462] [009/142] (917s left) syncobj_wait (single-wait-all-for-submit-submitted)
[83.775959] Starting subtest: single-wait-all-for-submit-submitted
[83.851239] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[83.960775] [010/142] (916s left) vc4/vc4_tiling (get-after-free)
[84.315247] Subtest get-after-free: SKIP (0.000s)
[84.396407] [011/142] (916s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[84.680996] Starting subtest: etime-single-wait-all-for-submit-submitted
[84.748565] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[84.856201] [012/142] (916s left) gem_exec_balancer (invalid-balancer)
[85.143848] Starting subtest: invalid-balancer
[89.030909] Subtest invalid-balancer: SUCCESS (3.717s)
[93.016227] [013/142] (908s left) kms_vblank (pipe-a-query-busy)
[93.372650] Starting subtest: pipe-A-query-busy
[95.836083] Subtest pipe-A-query-busy: SUCCESS (2.459s)
[96.206298] [014/142] (905s left) kms_fb_coherency (memset-crc)
[96.595154] Starting subtest: memset-crc
[96.615514] Starting dynamic subtest: mmap-gtt
[97.291522] Dynamic subtest mmap-gtt: SUCCESS (0.722s)
[97.440427] Starting dynamic subtest: mmap-offset-wc
[97.989808] Dynamic subtest mmap-offset-wc: SUCCESS (0.583s)
[98.116060] Starting dynamic subtest: mmap-offset-uc
[99.363286] Dynamic subtest mmap-offset-uc: SUCCESS (1.278s)
[99.487779] Starting dynamic subtest: mmap-legacy-wc
[100.086088] Dynamic subtest mmap-legacy-wc: SUCCESS (0.614s)
[100.200847] Subtest memset-crc: SUCCESS (3.615s)
[100.565491] [015/142] (900s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[101.008512] Starting subtest: fbc-rgb565-draw-mmap-cpu
[103.099714] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.169s)
[103.241086] [016/142] (898s left) gem_close_race (multigpu-basic-process)
[103.542769] Starting subtest: multigpu-basic-process
[103.580701] Subtest multigpu-basic-process: SKIP (0.000s)
[103.762797] [017/142] (897s left) syncobj_timeline (32bits-limit)
[104.052383] Starting subtest: 32bits-limit
[104.074044] Subtest 32bits-limit: SUCCESS (0.002s)
[104.159751] [018/142] (897s left) kms_ccs (pipe-b-bad-pixel-format-yf_tiled_ccs)
[104.691756] Starting subtest: pipe-B-bad-pixel-format-yf_tiled_ccs
[104.711239] Subtest pipe-B-bad-pixel-format-yf_tiled_ccs: SUCCESS (0.000s)
[105.234450] [019/142] (896s left) kms_ccs (pipe-c-bad-aux-stride-yf_tiled_ccs)
[105.958903] Starting subtest: pipe-C-bad-aux-stride-yf_tiled_ccs
[106.000754] Subtest pipe-C-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[106.307720] [020/142] (895s left) kms_addfb_basic (bad-pitch-1024)
[106.607490] Starting subtest: bad-pitch-1024
[106.628444] Subtest bad-pitch-1024: SUCCESS (0.000s)
[106.808445] [021/142] (895s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[107.168713] Starting subtest: primary-4-tiled-reflect-x-180
[107.208302] Subtest primary-4-tiled-reflect-x-180: SKIP (0.003s)
[107.311677] [022/142] (894s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[108.066806] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[108.416791] [023/142] (893s left) kms_flip (basic-flip-vs-wf_vblank)
[108.784477] Starting subtest: basic-flip-vs-wf_vblank
[108.803244] Starting dynamic subtest: A-DP1
[110.257917] Dynamic subtest A-DP1: SUCCESS (1.484s)
[110.291670] Starting dynamic subtest: B-DP1
[111.679442] Dynamic subtest B-DP1: SUCCESS (1.421s)
[111.715467] Starting dynamic subtest: C-DP1
[113.091138] Dynamic subtest C-DP1: SUCCESS (1.415s)
[113.110503] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.327s)
[113.552944] [024/142] (888s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[113.984828] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[114.064595] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.022s)
[114.171716] [025/142] (888s left) gem_exec_reloc (basic-gtt-cpu-active)
[114.472176] Starting subtest: basic-gtt-cpu-active
[114.591687] Subtest basic-gtt-cpu-active: SUCCESS (0.145s)
[114.813151] [026/142] (887s left) gem_exec_schedule (submit-late-slice)
[115.279577] Starting subtest: submit-late-slice
[115.300413] Starting dynamic subtest: rcs0
[115.319456] Dynamic subtest rcs0: SUCCESS (0.066s)
[115.356095] Starting dynamic subtest: bcs0
[115.378250] Dynamic subtest bcs0: SUCCESS (0.053s)
[115.415045] Starting dynamic subtest: vcs0
[115.435932] Dynamic subtest vcs0: SUCCESS (0.052s)
[115.471559] Starting dynamic subtest: vecs0
[115.491390] Dynamic subtest vecs0: SUCCESS (0.053s)
[115.510151] Subtest submit-late-slice: SUCCESS (0.226s)
[115.734384] [027/142] (886s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[116.153316] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[116.196372] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[116.303760] [028/142] (886s left) gem_exec_params (batch-first)
[116.605262] Starting subtest: batch-first
[116.624484] Subtest batch-first: SUCCESS (0.012s)
[116.753133] [029/142] (885s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[117.048549] Starting subtest: tiled-to-tiled
[117.169731] Subtest tiled-to-tiled: SUCCESS (0.117s)
[117.303283] [030/142] (885s left) gem_mmap_gtt (medium-copy-xy)
[117.602532] Starting subtest: medium-copy-XY
[123.817334] Subtest medium-copy-XY: SUCCESS (6.250s)
[123.934333] [031/142] (878s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[124.803734] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[124.845874] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[125.214748] [032/142] (877s left) gem_lmem_swapping (parallel-random)
[125.533253] Subtest parallel-random: SKIP (0.000s)
[125.637326] [033/142] (877s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[125.999571] Starting subtest: plane-primary-toggle-with-vblank-wait
[126.018520] Starting dynamic subtest: pipe-A-DP-1
[126.194290] Dynamic subtest pipe-A-DP-1: SUCCESS (0.201s)
[126.324652] Starting dynamic subtest: pipe-B-DP-1
[126.789548] Dynamic subtest pipe-B-DP-1: SUCCESS (0.487s)
[126.902691] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.896s)
[127.269170] [034/142] (875s left) kms_chamelium_edid (dp-edid-read)
[127.788828] Subtest dp-edid-read: SKIP (0.000s)
[128.112279] [035/142] (875s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[128.560915] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[128.601429] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[128.703689] [036/142] (874s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_mc_ccs)
[129.088659] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs
[129.129591] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[129.781130] [037/142] (873s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[130.222218] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[130.259615] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[130.369605] [038/142] (873s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[130.852165] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[130.892948] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[131.453729] [039/142] (872s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[131.870535] Starting subtest: cursorA-vs-flipA-legacy
[143.264059] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.304s)
[143.552492] [040/142] (860s left) gem_exec_whisper (basic-fds-forked-all)
[143.893902] Starting subtest: basic-fds-forked-all
[167.843871] Subtest basic-fds-forked-all: SUCCESS (23.976s)
[168.055542] [041/142] (835s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[168.617115] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[168.660415] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[169.137977] [042/142] (834s left) gem_exec_schedule (pi-shared-iova)
[169.603032] Starting subtest: pi-shared-iova
[169.622315] Starting dynamic subtest: rcs0
[169.670937] Dynamic subtest rcs0: SUCCESS (0.079s)
[169.712223] Starting dynamic subtest: bcs0
[169.733234] Dynamic subtest bcs0: SUCCESS (0.073s)
[169.771287] Starting dynamic subtest: vcs0
[169.790540] Dynamic subtest vcs0: SUCCESS (0.054s)
[169.829952] Starting dynamic subtest: vecs0
[169.849518] Dynamic subtest vecs0: SUCCESS (0.056s)
[169.871710] Subtest pi-shared-iova: SUCCESS (0.267s)
[170.124745] [043/142] (833s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[170.512180] Starting subtest: 2x-flip-vs-rmfb-interruptible
[170.554161] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.003s)
[170.661204] [044/142] (833s left) drm_fdinfo (busy-hang)
[170.962649] Starting subtest: busy-hang
[170.981774] Starting dynamic subtest: rcs0
[171.990612] Dynamic subtest rcs0: SUCCESS (1.040s)
[172.026262] Starting dynamic subtest: bcs0
[173.044543] Dynamic subtest bcs0: SUCCESS (1.051s)
[173.082562] Starting dynamic subtest: vcs0
[174.075591] Dynamic subtest vcs0: SUCCESS (1.040s)
[174.114025] Starting dynamic subtest: vecs0
[175.114462] Dynamic subtest vecs0: SUCCESS (1.043s)
[175.133534] Subtest busy-hang: SUCCESS (4.178s)
[175.225668] [045/142] (829s left) gem_ppgtt (shrink-vs-evict-pinned)
[175.528240] Starting subtest: shrink-vs-evict-pinned
[180.799623] Subtest shrink-vs-evict-pinned: SUCCESS (5.097s)
[180.886094] [046/142] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[181.329068] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[181.366649] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[181.476491] [047/142] (823s left) kms_vblank (pipe-b-wait-busy-hang)
[181.838971] Starting subtest: pipe-B-wait-busy-hang
[189.141392] Subtest pipe-B-wait-busy-hang: SUCCESS (7.182s)
[189.414870] [048/142] (815s left) gem_wait (invalid-flags)
[189.715613] Starting subtest: invalid-flags
[189.736482] Subtest invalid-flags: SUCCESS (0.000s)
[190.011193] [049/142] (814s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[190.385808] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[190.407261] Starting dynamic subtest: pipe-A-DP-1
[190.703629] Dynamic subtest pipe-A-DP-1: SUCCESS (0.319s)
[190.751397] Starting dynamic subtest: pipe-B-DP-1
[191.074152] Dynamic subtest pipe-B-DP-1: SUCCESS (0.363s)
[191.111275] Starting dynamic subtest: pipe-C-DP-1
[191.179657] Dynamic subtest pipe-C-DP-1: SKIP (0.091s)
[191.202421] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.784s)
[191.610061] [050/142] (813s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[192.124491] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[192.167384] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[192.691510] [051/142] (812s left) syncobj_timeline (wait-all-delayed-signal)
[192.987867] Starting subtest: wait-all-delayed-signal
[193.067278] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[193.203177] [052/142] (811s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[193.955771] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[194.285776] [053/142] (810s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[194.751263] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[194.800193] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[194.938306] [054/142] (810s left) sysfs_preempt_timeout (invalid)
[195.223686] Starting subtest: invalid
[195.244159] Starting dynamic subtest: vecs0
[195.266154] Dynamic subtest vecs0: SUCCESS (0.001s)
[195.305496] Starting dynamic subtest: vcs0
[195.326319] Dynamic subtest vcs0: SUCCESS (0.001s)
[195.364657] Starting dynamic subtest: bcs0
[195.384409] Dynamic subtest bcs0: SUCCESS (0.001s)
[195.420777] Starting dynamic subtest: rcs0
[195.439484] Dynamic subtest rcs0: SUCCESS (0.001s)
[195.459487] Subtest invalid: SUCCESS (0.011s)
[195.572827] [055/142] (809s left) v3d/v3d_wait_bo (map-bo-1ns)
[195.909910] Subtest map-bo-1ns: SKIP (0.000s)
[196.015392] [056/142] (809s left) gem_exec_reloc (basic-write-gtt)
[196.319804] Starting subtest: basic-write-gtt
[196.339141] Subtest basic-write-gtt: SUCCESS (0.019s)
[196.537697] [057/142] (809s left) perf_pmu (enable-race)
[196.839938] Starting subtest: enable-race
[196.858743] Starting dynamic subtest: rcs0
[209.682508] Dynamic subtest rcs0: SUCCESS (12.674s)
[209.720606] Starting dynamic subtest: bcs0
[222.394974] Dynamic subtest bcs0: SUCCESS (12.725s)
[222.431415] Starting dynamic subtest: vcs0
[234.908490] Dynamic subtest vcs0: SUCCESS (12.675s)
[234.946531] Starting dynamic subtest: vecs0
[247.751112] Dynamic subtest vecs0: SUCCESS (12.670s)
[247.772517] Subtest enable-race: SUCCESS (50.748s)
[247.883409] [058/142] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[248.305592] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[248.347747] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[248.457401] [059/142] (757s left) kms_vblank (pipe-d-ts-continuation-modeset)
[248.868683] Subtest pipe-D-ts-continuation-modeset: SKIP (0.000s)
[249.057941] [060/142] (756s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[249.423945] Starting subtest: primary-y-tiled-reflect-x-180
[249.461987] Subtest primary-y-tiled-reflect-x-180: SKIP (0.003s)
[249.575952] [061/142] (756s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[249.957674] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[249.977541] Starting dynamic subtest: A-DP1
[251.170259] Dynamic subtest A-DP1: SUCCESS (1.220s)
[251.209197] Starting dynamic subtest: B-DP1
[252.230989] Dynamic subtest B-DP1: SUCCESS (1.053s)
[252.270535] Starting dynamic subtest: C-DP1
[253.302165] Dynamic subtest C-DP1: SUCCESS (1.070s)
[253.322390] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.354s)
[253.666127] [062/142] (752s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[254.114191] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[254.155510] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[254.266591] [063/142] (751s left) kms_cursor_crc (cursor-random-256x85)
[254.660442] Starting subtest: cursor-random-256x85
[254.682213] Starting dynamic subtest: pipe-A-DP-1
[258.491977] Dynamic subtest pipe-A-DP-1: SUCCESS (3.809s)
[258.579973] Starting dynamic subtest: pipe-C-DP-1
[262.700417] Dynamic subtest pipe-C-DP-1: SUCCESS (4.141s)
[262.729465] Subtest cursor-random-256x85: SUCCESS (8.029s)
[263.103723] [064/142] (743s left) kms_properties (invalid-properties-legacy)
[263.477256] Starting subtest: invalid-properties-legacy
[263.605222] Subtest invalid-properties-legacy: SUCCESS (0.137s)
[263.743456] [065/142] (742s left) kms_vblank (pipe-d-ts-continuation-dpms-suspend)
[264.123556] Subtest pipe-D-ts-continuation-dpms-suspend: SKIP (0.000s)
[264.317397] [066/142] (742s left) prime_busy (before-wait)
[264.620682] Starting subtest: before-wait
[264.639884] Starting dynamic subtest: rcs0
[264.659122] Dynamic subtest rcs0: SUCCESS (0.023s)
[264.697805] Starting dynamic subtest: bcs0
[264.720147] Dynamic subtest bcs0: SUCCESS (0.023s)
[264.758992] Starting dynamic subtest: vcs0
[264.779658] Dynamic subtest vcs0: SUCCESS (0.013s)
[264.818195] Starting dynamic subtest: vecs0
[264.837157] Dynamic subtest vecs0: SUCCESS (0.024s)
[264.856249] Subtest before-wait: SUCCESS (0.220s)
[264.970483] [067/142] (741s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs)
[265.492284] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs
[265.513624] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SUCCESS (0.001s)
[266.077124] [068/142] (740s left) gem_sync (basic-store-all)
[266.537527] Starting subtest: basic-store-all
[270.362049] Subtest basic-store-all: SUCCESS (3.822s)
[270.451814] [069/142] (736s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[270.883630] Starting subtest: y-tiled-addfb-size-offset-overflow
[270.921512] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[271.077347] [070/142] (735s left) kms_addfb_basic (basic-y-tiled-legacy)
[271.375783] Starting subtest: basic-y-tiled-legacy
[271.397401] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[271.586097] [071/142] (735s left) gem_exec_fair (basic-none-rrul)
[272.068488] Starting subtest: basic-none-rrul
[272.087511] Starting dynamic subtest: rcs0
[277.237605] Dynamic subtest rcs0: SUCCESS (5.350s)
[277.256527] Subtest basic-none-rrul: SUCCESS (5.352s)
[277.471531] [072/142] (729s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[277.870417] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[277.913661] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[278.026388] [073/142] (729s left) syncobj_timeline (multi-wait-for-submit-signaled)
[278.322087] Starting subtest: multi-wait-for-submit-signaled
[278.341352] Subtest multi-wait-for-submit-signaled: SUCCESS (0.002s)
[278.428477] [074/142] (728s left) gem_exec_schedule (implicit-boths)
[278.882116] Starting subtest: implicit-boths
[278.901213] Starting dynamic subtest: rcs0
[278.920215] Dynamic subtest rcs0: SUCCESS (0.143s)
[278.962732] Starting dynamic subtest: bcs0
[279.010279] Dynamic subtest bcs0: SUCCESS (0.143s)
[279.051582] Starting dynamic subtest: vcs0
[279.141863] Dynamic subtest vcs0: SUCCESS (0.127s)
[279.182384] Starting dynamic subtest: vecs0
[279.266112] Dynamic subtest vecs0: SUCCESS (0.123s)
[279.287619] Subtest implicit-boths: SUCCESS (0.545s)
[279.652903] [075/142] (727s left) gen9_exec_parse (allowed-all)
[279.956061] Starting subtest: allowed-all
[279.975098] Subtest allowed-all: SUCCESS (0.004s)
[280.209950] [076/142] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[280.624210] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[280.665443] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[280.784561] [077/142] (726s left) v3d/v3d_submit_cl (bad-multisync-extension)
[281.125220] Subtest bad-multisync-extension: SKIP (0.000s)
[281.213526] [078/142] (726s left) kms_rmfb (rmfb-ioctl)
[281.580140] Starting subtest: rmfb-ioctl
[281.601767] Starting dynamic subtest: pipe-A-DP-1
[281.717158] Dynamic subtest pipe-A-DP-1: SUCCESS (0.125s)
[281.765910] Starting dynamic subtest: pipe-B-DP-1
[282.147951] Dynamic subtest pipe-B-DP-1: SUCCESS (0.437s)
[282.193390] Starting dynamic subtest: pipe-C-DP-1
[282.601334] Dynamic subtest pipe-C-DP-1: SUCCESS (0.439s)
[282.622798] Subtest rmfb-ioctl: SUCCESS (1.012s)
[283.047462] [079/142] (724s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[283.363444] Starting subtest: invalid-single-wait-all-unsubmitted
[283.384488] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[283.493151] [080/142] (724s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[283.850385] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[283.892076] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.002s)
[284.006989] [081/142] (724s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-25)
[284.373764] Starting subtest: plane-downscale-with-pixel-format-factor-0-25
[284.394561] Starting dynamic subtest: pipe-A-DP-1
[284.438468] Dynamic subtest pipe-A-DP-1: SKIP (0.038s)
[284.490507] Starting dynamic subtest: pipe-B-DP-1
[284.533881] Dynamic subtest pipe-B-DP-1: SKIP (0.089s)
[284.583464] Starting dynamic subtest: pipe-C-DP-1
[284.621032] Dynamic subtest pipe-C-DP-1: SKIP (0.090s)
[284.662638] Subtest plane-downscale-with-pixel-format-factor-0-25: SKIP (0.230s)
[284.796996] [082/142] (723s left) gem_eio (in-flight-10ms)
[285.142775] Starting subtest: in-flight-10ms
[286.246147] Subtest in-flight-10ms: SUCCESS (1.150s)
[286.515685] [083/142] (721s left) kms_atomic (plane-invalid-params)
[287.006856] Starting subtest: plane-invalid-params
[287.159285] Subtest plane-invalid-params: SUCCESS (0.149s)
[287.637624] [084/142] (720s left) kms_psr (psr2_dpms)
[287.958320] Subtest psr2_dpms: SKIP (0.000s)
[288.065684] [085/142] (720s left) kms_atomic_interruptible (legacy-cursor)
[288.435663] Starting subtest: legacy-cursor
[288.462928] Starting dynamic subtest: DP-1-pipe-A
[294.987366] Dynamic subtest DP-1-pipe-A: SUCCESS (6.558s)
[295.007077] Subtest legacy-cursor: SUCCESS (6.564s)
[295.373987] [086/142] (713s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[295.767989] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[295.789070] Starting dynamic subtest: pipe-A-valid-mode
[295.888317] Dynamic subtest pipe-A-valid-mode: SKIP (0.089s)
[295.927399] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.092s)
[296.210135] [087/142] (712s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[296.894483] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[296.938942] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[297.332276] [088/142] (711s left) kms_chamelium_hpd (dp-hpd-storm)
[297.813947] Subtest dp-hpd-storm: SKIP (0.000s)
[298.154634] [089/142] (710s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_mc_ccs)
[298.923436] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[299.255421] [090/142] (709s left) gem_ctx_shared (detached-shared-gtt)
[299.553506] Starting subtest: detached-shared-gtt
[301.867528] Subtest detached-shared-gtt: SUCCESS (2.150s)
[302.040417] [091/142] (707s left) syncobj_wait (multi-wait-signaled)
[302.338138] Starting subtest: multi-wait-signaled
[302.358945] Subtest multi-wait-signaled: SUCCESS (0.001s)
[302.468287] [092/142] (706s left) syncobj_wait (multi-wait-all-signaled)
[302.763406] Starting subtest: multi-wait-all-signaled
[302.782643] Subtest multi-wait-all-signaled: SUCCESS (0.002s)
[302.894649] [093/142] (706s left) gem_eio (in-flight-contexts-immediate)
[303.231474] Starting subtest: in-flight-contexts-immediate
[314.284796] Subtest in-flight-contexts-immediate: SUCCESS (11.122s)
[314.536688] [094/142] (694s left) gem_exec_fence (syncobj-import)
[315.275801] Starting subtest: syncobj-import
[315.297404] Subtest syncobj-import: SUCCESS (0.007s)
[315.666139] [095/142] (693s left) i915_pm_dc (dc5-dpms)
[317.028989] Starting subtest: dc5-dpms
[318.418810] Subtest dc5-dpms: SUCCESS (1.404s)
[318.655266] [096/142] (691s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[319.002388] Starting subtest: read-crc-frame-sequence
[319.021460] Starting dynamic subtest: pipe-A-DP-1
[319.552586] Dynamic subtest pipe-A-DP-1: SUCCESS (0.530s)
[319.598893] Starting dynamic subtest: pipe-B-DP-1
[320.360783] Dynamic subtest pipe-B-DP-1: SUCCESS (0.804s)
[320.407257] Starting dynamic subtest: pipe-C-DP-1
[321.324959] Dynamic subtest pipe-C-DP-1: SUCCESS (0.974s)
[321.346930] Subtest read-crc-frame-sequence: SUCCESS (2.324s)
[321.691063] [097/142] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[322.141118] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[322.178772] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[322.296781] [098/142] (687s left) gem_mmap_gtt (hang-busy)
[322.577099] Starting subtest: hang-busy
[337.428175] Subtest hang-busy: SUCCESS (14.691s)
[337.547101] [099/142] (672s left) gem_softpin (evict-single-offset)
[337.843286] Starting subtest: evict-single-offset
[373.296979] Subtest evict-single-offset: SUCCESS (35.470s)
[373.426290] [100/142] (636s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[373.993655] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[374.012925] Starting dynamic subtest: pipe-A-valid-mode
[374.155953] Dynamic subtest pipe-A-valid-mode: SKIP (0.152s)
[374.195823] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.156s)
[374.514129] [101/142] (635s left) kms_vblank (pipe-b-ts-continuation-dpms-suspend)
[374.938734] Starting subtest: pipe-B-ts-continuation-dpms-suspend
[392.405849] Subtest pipe-B-ts-continuation-dpms-suspend: SUCCESS (2.502s)
[399.013248] [102/142] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[399.442022] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[399.483597] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[399.604295] [103/142] (631s left) gem_tiled_pread_basic
[400.265960] [104/142] (631s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[400.757573] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[401.096563] [105/142] (630s left) gem_exec_params (invalid-fence-in)
[401.393517] Starting subtest: invalid-fence-in
[401.415165] Subtest invalid-fence-in: SUCCESS (0.001s)
[401.532366] [106/142] (630s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[402.158235] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[402.199712] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.005s)
[402.631540] [107/142] (629s left) gem_ctx_exec (basic-close-race)
[402.934774] Starting subtest: basic-close-race
[408.566628] Subtest basic-close-race: SUCCESS (5.483s)
[408.897394] [108/142] (623s left) gem_mmap (basic)
[409.193776] Starting subtest: basic
[409.292435] Subtest basic: SUCCESS (0.001s)
[409.391435] [109/142] (622s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[409.740236] Starting subtest: flip-vs-cursor-atomic
[425.798454] Subtest flip-vs-cursor-atomic: SUCCESS (16.047s)
[426.170221] [110/142] (606s left) feature_discovery (psr2)
[426.514364] Starting subtest: psr2
[426.555238] Subtest psr2: SKIP (0.000s)
[426.678303] [111/142] (605s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs)
[427.336164] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs
[427.378911] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[427.781919] [112/142] (604s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[428.198020] Starting subtest: psr-rgb565-draw-mmap-wc
[428.240789] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[428.360254] [113/142] (604s left) vgem_basic (bad-handle)
[428.661112] Starting subtest: bad-handle
[428.680295] Subtest bad-handle: SUCCESS (0.000s)
[428.794960] [114/142] (603s left) kms_plane_multiple (tiling-4)
[429.160020] Starting subtest: tiling-4
[429.202151] Subtest tiling-4: SKIP (0.000s)
[429.316953] [115/142] (603s left) api_intel_allocator (simple-allocator)
[429.620198] Starting subtest: simple-allocator
[429.639084] Starting dynamic subtest: basic
[429.657918] Dynamic subtest basic: SUCCESS (0.007s)
[429.704902] Starting dynamic subtest: parallel-one
[429.759382] Dynamic subtest parallel-one: SUCCESS (0.159s)
[429.804150] Starting dynamic subtest: print
[429.823209] Dynamic subtest print: SUCCESS (0.000s)
[429.866148] Starting dynamic subtest: reuse
[429.885184] Dynamic subtest reuse: SUCCESS (0.000s)
[429.927877] Starting dynamic subtest: reserve
[429.949472] Dynamic subtest reserve: SUCCESS (0.000s)
[429.993591] Starting dynamic subtest: fork-reopen-allocator
[430.014910] Dynamic subtest fork-reopen-allocator: SUCCESS (0.042s)
[430.035624] Subtest simple-allocator: SUCCESS (0.223s)
[430.147218] [116/142] (602s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[430.543907] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[431.851849] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.333s)
[432.227601] [117/142] (600s left) i915_pm_rpm (pm-caching)
[434.080052] Starting subtest: pm-caching
[435.648594] Subtest pm-caching: SUCCESS (1.569s)
[436.137617] [118/142] (596s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[439.188352] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[439.298307] [119/142] (593s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[439.716337] Starting subtest: 4-tiled-64bpp-rotate-90
[439.767209] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[439.914098] [120/142] (593s left) syncobj_wait (invalid-reset-illegal-handle)
[440.257249] Starting subtest: invalid-reset-illegal-handle
[440.277314] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[440.388082] [121/142] (593s left) kms_rotation_crc (sprite-rotation-180)
[440.751936] Starting subtest: sprite-rotation-180
[445.115249] Subtest sprite-rotation-180: SUCCESS (4.373s)
[445.586717] [122/142] (587s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[445.887625] Starting subtest: writes-after-reads-uncached
[466.702565] Subtest writes-after-reads-uncached: SUCCESS (20.822s)
[466.838782] [123/142] (566s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[467.262895] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[467.305256] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[467.422762] [124/142] (566s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[467.835983] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[467.876608] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[467.988270] [125/142] (565s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[468.324364] Subtest bad-multisync-out-sync: SKIP (0.000s)
[468.420788] [126/142] (565s left) i915_pm_freq_api (freq-reset-multiple)
[468.739313] Subtest freq-reset-multiple: SKIP (0.000s)
[468.838726] [127/142] (565s left) kms_cursor_crc (cursor-onscreen-64x21)
[469.215973] Starting subtest: cursor-onscreen-64x21
[469.234730] Starting dynamic subtest: pipe-A-DP-1
[471.559789] Dynamic subtest pipe-A-DP-1: SUCCESS (2.341s)
[471.669428] Starting dynamic subtest: pipe-C-DP-1
[474.284112] Dynamic subtest pipe-C-DP-1: SUCCESS (2.672s)
[474.303151] Subtest cursor-onscreen-64x21: SUCCESS (5.090s)
[474.702328] [128/142] (559s left) gem_fence_thrash (bo-write-verify-threaded-y)
[474.980112] Starting subtest: bo-write-verify-threaded-y
[477.618252] Subtest bo-write-verify-threaded-y: SUCCESS (2.481s)
[477.716598] [129/142] (556s left) kms_frontbuffer_tracking (psr-1p-rte)
[478.136380] Starting subtest: psr-1p-rte
[478.173032] Subtest psr-1p-rte: SKIP (0.000s)
[478.292641] [130/142] (556s left) kms_cursor_edge_walk (256x256-left-edge)
[478.640352] Starting subtest: 256x256-left-edge
[478.658967] Starting dynamic subtest: pipe-A-DP-1
[482.331955] Dynamic subtest pipe-A-DP-1: SUCCESS (3.685s)
[482.380865] Starting dynamic subtest: pipe-C-DP-1
[485.854197] Dynamic subtest pipe-C-DP-1: SUCCESS (3.515s)
[485.873283] Subtest 256x256-left-edge: SUCCESS (7.211s)
[486.214088] [131/142] (548s left) kms_cursor_crc (cursor-dpms)
[486.577779] Starting subtest: cursor-dpms
[486.596549] Starting dynamic subtest: pipe-A-DP-1
[488.045517] Dynamic subtest pipe-A-DP-1: SUCCESS (1.454s)
[488.104045] Starting dynamic subtest: pipe-C-DP-1
[489.806351] Dynamic subtest pipe-C-DP-1: SUCCESS (1.754s)
[489.825422] Subtest cursor-dpms: SUCCESS (3.219s)
[490.213904] [132/142] (544s left) kms_psr (primary_page_flip)
[490.542934] Subtest primary_page_flip: SKIP (0.000s)
[490.656083] [133/142] (544s left) perf (i915-ref-count)
[491.022622] Starting subtest: i915-ref-count
[491.160835] Subtest i915-ref-count: SUCCESS (0.137s)
[491.294879] [134/142] (543s left) gem_ctx_persistence (engines-persistence)
[491.593086] Starting subtest: engines-persistence
[491.614248] Starting dynamic subtest: rcs0
[492.374796] Dynamic subtest rcs0: SUCCESS (0.800s)
[492.417041] Starting dynamic subtest: bcs0
[493.135970] Dynamic subtest bcs0: SUCCESS (0.761s)
[493.181219] Starting dynamic subtest: vcs0
[493.916498] Dynamic subtest vcs0: SUCCESS (0.776s)
[493.958802] Starting dynamic subtest: vecs0
[494.672683] Dynamic subtest vecs0: SUCCESS (0.755s)
[494.693986] Subtest engines-persistence: SUCCESS (3.103s)
[494.795346] [135/142] (540s left) kms_prop_blob (blob-prop-validate)
[495.091830] Starting subtest: blob-prop-validate
[495.112129] Subtest blob-prop-validate: SUCCESS (0.000s)
[495.206963] [136/142] (539s left) gem_userptr_blits (userfault)
[495.561618] Starting subtest: userfault
[495.580113] Subtest userfault: SUCCESS (0.007s)
[495.701527] [137/142] (539s left) kms_lease (lease_get)
[496.063102] Starting subtest: lease_get
[496.081936] Starting dynamic subtest: pipe-A-DP-1
[496.100450] Dynamic subtest pipe-A-DP-1: SUCCESS (0.005s)
[496.143633] Starting dynamic subtest: pipe-B-DP-1
[496.164862] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s)
[496.209263] Starting dynamic subtest: pipe-C-DP-1
[496.229484] Dynamic subtest pipe-C-DP-1: SUCCESS (0.001s)
[496.249719] Subtest lease_get: SUCCESS (0.021s)
[496.364146] [138/142] (538s left) i915_query (query-regions-garbage-items)
[496.666568] Starting subtest: query-regions-garbage-items
[496.685085] Subtest query-regions-garbage-items: SUCCESS (0.001s)
[496.787768] [139/142] (538s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[497.088500] Starting subtest: basic-gtt-cpu-noreloc
[497.109881] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.012s)
[497.329118] [140/142] (538s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[497.760521] Starting subtest: x-tiled-16bpp-rotate-180
[501.388143] Subtest x-tiled-16bpp-rotate-180: SUCCESS (3.672s)
[501.750847] [141/142] (533s left) gem_userptr_blits (process-exit)
[502.118504] Starting subtest: process-exit
[502.137322] Subtest process-exit: SUCCESS (0.036s)
[502.264089] [142/142] (533s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[502.656864] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[504.188012] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.546s)
[504.342178] Closing watchdogs
Done.