[35.521429] Initializing watchdogs
[35.521495]   /dev/watchdog0
[35.527518] [001/142] (960s left) kms_lease (lease_unleased_crtc)
[37.483610] Starting subtest: lease_unleased_crtc
[37.484761] Starting dynamic subtest: pipe-A-HDMI-A-4
[37.557139] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.073s)
[37.562873] Starting dynamic subtest: pipe-B-HDMI-A-4
[37.597463] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.036s)
[37.601935] Starting dynamic subtest: pipe-C-HDMI-A-4
[37.647016] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.048s)
[37.651475] Starting dynamic subtest: pipe-D-HDMI-A-4
[37.691465] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.047s)
[37.692373] Subtest lease_unleased_crtc: SUCCESS (0.209s)
[37.791743] [002/142] (958s left) kms_dsc (dsc-with-output-formats-with-bpc)
[39.778525] Starting subtest: dsc-with-output-formats-with-bpc
[39.780694] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[39.845044] [003/142] (956s left) api_intel_allocator (reserve-simple)
[39.939165] Starting subtest: reserve-simple
[39.975055] Subtest reserve-simple: SUCCESS (0.037s)
[40.067707] [004/142] (956s left) vgem_basic (bad-handle)
[40.180040] Starting subtest: bad-handle
[40.181185] Subtest bad-handle: SUCCESS (0.000s)
[40.227316] [005/142] (955s left) feature_discovery (display-4x)
[42.183767] Starting subtest: display-4x
[42.185815] Subtest display-4x: SKIP (0.000s)
[42.244401] [006/142] (953s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[44.315069] Starting subtest: x-tiled-16bpp-rotate-0
[46.032824] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.714s)
[46.162309] [007/142] (949s left) gem_render_copy (yf-tiled-to-vebox-linear)
[46.219205] Starting subtest: yf-tiled-to-vebox-linear
[46.220143] Starting dynamic subtest: smem
[46.295182] Dynamic subtest smem: SUCCESS (0.076s)
[46.299984] Starting dynamic subtest: lmem0
[46.429613] Dynamic subtest lmem0: SUCCESS (0.131s)
[46.430558] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.208s)
[46.630230] [008/142] (949s left) gem_userptr_blits (coherency-sync)
[46.694886] Starting subtest: coherency-sync
[47.152303] Subtest coherency-sync: SKIP (0.448s)
[47.293115] [009/142] (948s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[49.334231] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[49.336126] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[49.413521] [010/142] (946s left) gem_exec_whisper (basic-forked)
[49.554170] Starting subtest: basic-forked
[55.700612] Subtest basic-forked: SUCCESS (6.145s)
[55.928199] [011/142] (940s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[57.923944] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[60.132613] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (2.210s)
[60.289566] [012/142] (935s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[62.308316] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[62.778264] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SUCCESS (0.469s)
[63.099319] [013/142] (933s left) kms_vblank (pipe-a-query-busy)
[65.056496] Starting subtest: pipe-A-query-busy
[67.505212] Subtest pipe-A-query-busy: SUCCESS (2.449s)
[67.607912] [014/142] (928s left) kms_psr (psr2_primary_mmap_cpu)
[67.659303] Subtest psr2_primary_mmap_cpu: SKIP (0.000s)
[67.689548] [015/142] (928s left) i915_pm_freq_api (freq-reset-multiple)
[67.754639] Starting subtest: freq-reset-multiple
[67.755590] Starting dynamic subtest: gt0
[81.205933] Dynamic subtest gt0: SUCCESS (13.451s)
[81.206770] Subtest freq-reset-multiple: SUCCESS (13.451s)
[81.257209] [016/142] (915s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[83.207459] Starting subtest: compare-crc-sanitycheck-xr24
[83.210437] Starting dynamic subtest: pipe-A-HDMI-A-4
[83.706549] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.497s)
[83.719252] Starting dynamic subtest: pipe-B-HDMI-A-4
[84.083373] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.374s)
[84.091894] Starting dynamic subtest: pipe-C-HDMI-A-4
[84.472280] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.387s)
[84.479751] Starting dynamic subtest: pipe-D-HDMI-A-4
[84.869221] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.395s)
[84.870170] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.662s)
[85.012265] [017/142] (911s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[86.966158] Starting subtest: plane-all-transition-nonblocking-fencing
[86.968384] Starting dynamic subtest: pipe-A-HDMI-A-4
[90.794958] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.826s)
[90.871139] Starting dynamic subtest: pipe-B-HDMI-A-4
[94.748212] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (3.882s)
[94.803126] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.837s)
[94.911750] [018/142] (901s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_mc_ccs)
[97.016544] Starting subtest: pipe-D-crc-primary-basic-y_tiled_gen12_mc_ccs
[97.021667] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[97.147050] [019/142] (899s left) kms_chamelium_color (ctm-negative)
[99.151026] Subtest ctm-negative: SKIP (0.000s)
[99.169259] [020/142] (897s left) i915_pm_rps (basic-api)
[99.218219] Starting subtest: basic-api
[99.219796] Subtest basic-api: SKIP (0.000s)
[99.283447] [021/142] (897s left) kms_ccs (pipe-a-random-ccs-data-yf_tiled_ccs)
[101.346846] Starting subtest: pipe-A-random-ccs-data-yf_tiled_ccs
[101.349985] Subtest pipe-A-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[101.559993] [022/142] (894s left) gem_tiling_max_stride
[101.637321] [023/142] (894s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[103.599459] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[104.599929] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.000s)
[104.720733] [024/142] (891s left) vc4/vc4_perfmon (create-perfmon-0)
[104.805332] Subtest create-perfmon-0: SKIP (0.000s)
[104.856531] [025/142] (891s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[106.810604] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[106.811600] Starting dynamic subtest: pipe-A-valid-mode
[106.860452] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s)
[106.862500] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.049s)
[106.944458] [026/142] (889s left) vgem_basic (second-client)
[107.013020] Starting subtest: second-client
[107.047542] Subtest second-client: SUCCESS (0.033s)
[107.139080] [027/142] (889s left) sw_sync (alloc_merge_fence)
[107.214835] Starting subtest: alloc_merge_fence
[107.215955] Subtest alloc_merge_fence: SUCCESS (0.000s)
[107.262337] [028/142] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[109.242712] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[109.244368] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[109.313601] [029/142] (887s left) gem_partial_pwrite_pread (writes-after-reads-display)
[109.450425] Subtest writes-after-reads-display: SKIP (0.000s)
[109.507534] [030/142] (887s left) kms_chamelium_audio (hdmi-audio)
[111.518324] Subtest hdmi-audio: SKIP (0.000s)
[111.571381] [031/142] (885s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[113.529390] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[113.531043] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[113.613785] [032/142] (883s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[113.766928] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[113.783980] [033/142] (882s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[115.741614] Starting subtest: psr-1p-primscrn-spr-indfb-move
[115.743706] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[115.832126] [034/142] (880s left) syncobj_wait (invalid-reset-illegal-handle)
[115.974624] Starting subtest: invalid-reset-illegal-handle
[115.975635] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[116.044774] [035/142] (880s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[118.011155] Starting subtest: cursorA-vs-flipA-toggle
[128.946233] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.935s)
[129.063617] [036/142] (867s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[131.250429] Starting subtest: cursor-rapid-movement-max-size
[131.253315] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[131.404873] [037/142] (865s left) prime_vgem (basic-fence-mmap)
[131.485789] Starting subtest: basic-fence-mmap
[131.487722] Subtest basic-fence-mmap: SKIP (0.000s)
[131.593616] [038/142] (865s left) kms_vblank (pipe-b-wait-forked-busy-hang)
[133.542901] Starting subtest: pipe-B-wait-forked-busy-hang
[147.864292] Subtest pipe-B-wait-forked-busy-hang: SUCCESS (14.321s)
[147.987787] [039/142] (848s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[152.417676] Starting subtest: dpms-mode-unset-non-lpsp
[162.284641] Subtest dpms-mode-unset-non-lpsp: SUCCESS (9.868s)
[163.447901] [040/142] (833s left) gem_ctx_persistence (userptr)
[163.507555] Starting subtest: userptr
[163.654847] Subtest userptr: SUCCESS (0.146s)
[163.769887] [041/142] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[165.764397] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[165.766380] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[165.855093] [042/142] (830s left) syncobj_wait (wait-any-snapshot)
[165.995723] Starting subtest: wait-any-snapshot
[166.077291] Subtest wait-any-snapshot: SUCCESS (0.082s)
[166.176186] [043/142] (830s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25)
[168.158789] Starting subtest: plane-downscale-with-modifiers-factor-0-25
[168.159734] Starting dynamic subtest: pipe-A-HDMI-A-4
[168.202537] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.043s)
[168.210686] Starting dynamic subtest: pipe-B-HDMI-A-4
[168.246138] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.040s)
[168.252841] Starting dynamic subtest: pipe-C-HDMI-A-4
[168.288766] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.040s)
[168.295466] Starting dynamic subtest: pipe-D-HDMI-A-4
[168.330616] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.040s)
[168.332174] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (0.173s)
[168.446925] [044/142] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[170.448444] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[170.450493] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[170.515884] [045/142] (826s left) prime_busy (after)
[170.603126] Starting subtest: after
[170.613853] Starting dynamic subtest: rcs0
[170.661255] Dynamic subtest rcs0: SUCCESS (0.048s)
[170.670027] Starting dynamic subtest: bcs0
[170.712296] Dynamic subtest bcs0: SUCCESS (0.050s)
[170.731390] Starting dynamic subtest: vcs0
[170.755787] Dynamic subtest vcs0: SUCCESS (0.041s)
[170.776269] Starting dynamic subtest: vcs1
[170.800077] Dynamic subtest vcs1: SUCCESS (0.042s)
[170.820535] Starting dynamic subtest: vecs0
[170.842837] Dynamic subtest vecs0: SUCCESS (0.041s)
[170.955718] Subtest after: SUCCESS (0.350s)
[171.086611] [046/142] (825s left) gem_exec_fence (syncobj-timeline-wait)
[171.641272] Starting subtest: syncobj-timeline-wait
[171.714916] Subtest syncobj-timeline-wait: SUCCESS (0.076s)
[171.923043] [047/142] (825s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[171.994290] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[171.995251] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[172.065626] [048/142] (824s left) i915_suspend (sysfs-reader)
[172.117460] Starting subtest: sysfs-reader
[193.741545] Subtest sysfs-reader: SUCCESS (10.897s)
[196.763655] [049/142] (813s left) kms_hdr (invalid-metadata-sizes)
[198.718516] Starting subtest: invalid-metadata-sizes
[198.720553] Subtest invalid-metadata-sizes: SKIP (0.000s)
[198.774767] [050/142] (812s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[200.810295] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[200.812490] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[200.896273] [051/142] (809s left) gem_mmap_gtt (basic-small-copy-xy)
[201.030096] Subtest basic-small-copy-XY: SKIP (0.000s)
[201.064339] [052/142] (809s left) prime_vgem (coherency-blt)
[201.126730] Starting subtest: coherency-blt
[203.304450] Subtest coherency-blt: SUCCESS (2.174s)
[203.401928] [053/142] (807s left) gen9_exec_parse (bb-large)
[203.480728] Subtest bb-large: SKIP (0.000s)
[203.516421] [054/142] (807s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[205.583142] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[205.656423] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.072s)
[205.862374] [055/142] (805s left) drm_fdinfo (all-busy-check-all)
[205.919618] Starting subtest: all-busy-check-all
[205.935695] Subtest all-busy-check-all: SKIP (0.015s)
[206.002342] [056/142] (804s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[207.996321] Starting subtest: primary-y-tiled-reflect-x-180
[218.671580] Subtest primary-y-tiled-reflect-x-180: SUCCESS (10.674s)
[218.857310] [057/142] (792s left) kms_rotation_crc (cursor-rotation-180)
[220.806359] Starting subtest: cursor-rotation-180
[221.633731] Subtest cursor-rotation-180: SUCCESS (0.826s)
[221.851034] [058/142] (789s left) perf (buffer-fill)
[221.965105] Starting subtest: buffer-fill
[221.966079] Starting dynamic subtest: 0-rcs0
[224.201943] Dynamic subtest 0-rcs0: SUCCESS (2.234s)
[224.203105] Subtest buffer-fill: SUCCESS (2.235s)
[224.233957] [059/142] (786s left) gem_madvise (dontneed-before-exec)
[224.279918] Starting subtest: dontneed-before-exec
[224.283878] Subtest dontneed-before-exec: SKIP (0.002s)
[224.328663] [060/142] (786s left) kms_draw_crc (draw-method-mmap-wc)
[226.319490] Starting subtest: draw-method-mmap-wc
[226.321532] Subtest draw-method-mmap-wc: SKIP (0.000s)
[226.409951] [061/142] (784s left) v3d/v3d_submit_cl (job-perfmon)
[226.583554] Subtest job-perfmon: SKIP (0.000s)
[226.639457] [062/142] (784s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[226.701714] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[226.730002] [063/142] (784s left) kms_cursor_crc (cursor-random-64x64)
[228.767358] Starting subtest: cursor-random-64x64
[228.774224] Starting dynamic subtest: pipe-A-HDMI-A-4
[233.371142] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.597s)
[233.398801] Starting dynamic subtest: pipe-D-HDMI-A-4
[237.784705] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.392s)
[237.785717] Subtest cursor-random-64x64: SUCCESS (9.017s)
[238.171416] [064/142] (772s left) kms_vblank (pipe-b-ts-continuation-modeset)
[240.124455] Starting subtest: pipe-B-ts-continuation-modeset
[240.504177] Subtest pipe-B-ts-continuation-modeset: SUCCESS (0.379s)
[240.617520] [065/142] (770s left) gem_exec_flush (basic-wb-prw-default)
[240.669798] Subtest basic-wb-prw-default: SKIP (0.000s)
[240.709363] [066/142] (770s left) kms_pm_backlight (fade-with-dpms)
[242.664368] Subtest fade-with-dpms: SKIP (0.000s)
[242.693390] [067/142] (768s left) gem_exec_params (invalid-ring2)
[242.750131] Starting subtest: invalid-ring2
[242.751357] Subtest invalid-ring2: SUCCESS (0.000s)
[242.896913] [068/142] (768s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[242.961854] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[242.962810] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[243.019481] [069/142] (768s left) gem_mmap_wc (bad-offset)
[243.080127] Subtest bad-offset: SKIP (0.000s)
[243.109483] [070/142] (768s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[245.208083] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[245.211493] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.003s)
[245.339626] [071/142] (765s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[245.387880] Starting subtest: invalid-single-wait-all-unsubmitted
[245.388818] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[245.480307] [072/142] (765s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[247.477862] Starting subtest: y-tiled-8bpp-rotate-270
[247.558056] Subtest y-tiled-8bpp-rotate-270: SKIP (0.078s)
[247.656264] [073/142] (763s left) kms_async_flips (alternate-sync-async-flip)
[249.615803] Starting subtest: alternate-sync-async-flip
[249.763010] Starting dynamic subtest: pipe-A-HDMI-A-4
[252.067516] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.300s)
[252.209945] Starting dynamic subtest: pipe-B-HDMI-A-4
[254.248348] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.042s)
[254.404341] Starting dynamic subtest: pipe-C-HDMI-A-4
[256.448543] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.048s)
[256.599179] Starting dynamic subtest: pipe-D-HDMI-A-4
[258.643824] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.048s)
[258.645964] Subtest alternate-sync-async-flip: SUCCESS (9.027s)
[258.887761] [074/142] (752s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[260.896309] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[260.897878] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[261.122373] [075/142] (750s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[263.077909] Starting subtest: cursorB-vs-flipB-varying-size
[263.082061] Subtest cursorB-vs-flipB-varying-size: SKIP (0.002s)
[263.140608] [076/142] (748s left) kms_vblank (pipe-d-ts-continuation-idle)
[265.147537] Starting subtest: pipe-D-ts-continuation-idle
[265.429953] Subtest pipe-D-ts-continuation-idle: SUCCESS (0.284s)
[265.530325] [077/142] (745s left) gem_pxp (reject-modify-context-protection-off-3)
[268.101070] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[268.175873] [078/142] (743s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[268.245577] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[268.297847] [079/142] (743s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[269.305071] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[269.330786] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.025s)
[269.398085] [080/142] (742s left) kms_busy (basic-hang)
[271.404578] Starting subtest: basic-hang
[271.407591] Starting dynamic subtest: flip-pipe-A
[272.034338] Dynamic subtest flip-pipe-A: SUCCESS (0.627s)
[272.042949] Starting dynamic subtest: modeset-pipe-A
[272.595363] Dynamic subtest modeset-pipe-A: SUCCESS (0.560s)
[272.607385] Starting dynamic subtest: flip-pipe-D
[273.063781] Dynamic subtest flip-pipe-D: SUCCESS (0.464s)
[273.072915] Starting dynamic subtest: modeset-pipe-D
[273.615593] Dynamic subtest modeset-pipe-D: SUCCESS (0.551s)
[273.616509] Subtest basic-hang: SUCCESS (2.212s)
[273.745459] [081/142] (737s left) kms_vblank (pipe-a-query-busy-hang)
[275.695566] Starting subtest: pipe-A-query-busy-hang
[289.612558] Subtest pipe-A-query-busy-hang: SUCCESS (13.917s)
[289.726541] [082/142] (721s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[291.677568] Starting subtest: modeset-transition-nonblocking-fencing
[291.678569] Starting dynamic subtest: 1x-outputs
[296.377593] Dynamic subtest 1x-outputs: SUCCESS (4.700s)
[296.416265] Subtest modeset-transition-nonblocking-fencing: SUCCESS (4.738s)
[296.529798] [083/142] (714s left) gem_set_tiling_vs_pwrite
[296.604627] [084/142] (714s left) gem_exec_schedule (promotion)
[296.663116] Starting subtest: promotion
[296.663933] Starting dynamic subtest: rcs0
[296.845594] Dynamic subtest rcs0: SUCCESS (0.179s)
[296.854020] Starting dynamic subtest: bcs0
[296.971734] Dynamic subtest bcs0: SUCCESS (0.128s)
[296.981513] Starting dynamic subtest: vcs0
[297.097424] Dynamic subtest vcs0: SUCCESS (0.124s)
[297.107480] Starting dynamic subtest: vcs1
[297.237235] Dynamic subtest vcs1: SUCCESS (0.139s)
[297.247184] Starting dynamic subtest: vecs0
[297.379136] Dynamic subtest vecs0: SUCCESS (0.141s)
[297.380069] Subtest promotion: SUCCESS (0.717s)
[297.824396] [085/142] (713s left) perf_pmu (busy-accuracy-98)
[297.902902] Starting subtest: busy-accuracy-98
[297.903806] Starting dynamic subtest: rcs0
[300.946871] Dynamic subtest rcs0: SUCCESS (3.042s)
[300.956380] Starting dynamic subtest: bcs0
[303.992176] Dynamic subtest bcs0: SUCCESS (3.044s)
[304.001808] Starting dynamic subtest: vcs0
[307.043321] Dynamic subtest vcs0: SUCCESS (3.045s)
[307.052956] Starting dynamic subtest: vcs1
[310.081742] Dynamic subtest vcs1: SUCCESS (3.043s)
[310.091026] Starting dynamic subtest: vecs0
[313.125871] Dynamic subtest vecs0: SUCCESS (3.043s)
[313.126776] Subtest busy-accuracy-98: SUCCESS (15.223s)
[313.233812] [086/142] (698s left) gem_ccs (block-copy-uncompressed)
[313.282314] Starting subtest: block-copy-uncompressed
[313.283094] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[313.311524] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.028s)
[313.322207] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[313.326829] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[313.337510] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[313.387520] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.059s)
[313.397965] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[313.446167] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.058s)
[313.456680] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[313.461158] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.014s)
[313.471640] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-lmem0
[313.474725] Dynamic subtest ymajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.012s)
[313.485152] Starting dynamic subtest: ymajor-uncompressed-compfmt0-lmem0-smem
[313.534618] Dynamic subtest ymajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.059s)
[313.545108] Starting dynamic subtest: ymajor-uncompressed-compfmt0-lmem0-lmem0
[313.593280] Dynamic subtest ymajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.058s)
[313.594161] Subtest block-copy-uncompressed: SUCCESS (0.311s)
[313.728576] [087/142] (697s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[315.715205] Starting subtest: yf-tiled-8bpp-rotate-0
[315.717083] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[315.806644] [088/142] (695s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_mc_ccs)
[318.016365] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs
[318.018377] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[318.145511] [089/142] (693s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[318.196830] Starting subtest: framebuffer-vs-set-tiling
[318.198413] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[320.184038] [090/142] (691s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[322.249499] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[322.307237] [091/142] (689s left) syncobj_timeline (reset-unsignaled)
[322.356909] Starting subtest: reset-unsignaled
[322.357734] Subtest reset-unsignaled: SUCCESS (0.000s)
[322.437688] [092/142] (689s left) gem_ctx_engines (execute-oneforall)
[322.519247] Starting subtest: execute-oneforall
[322.998603] Subtest execute-oneforall: SUCCESS (0.479s)
[323.386709] [093/142] (688s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[325.345665] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[325.348936] Starting dynamic subtest: pipe-A-HDMI-A-4
[325.517424] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.168s)
[325.562952] Starting dynamic subtest: pipe-B-HDMI-A-4
[325.688354] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.158s)
[325.699380] Starting dynamic subtest: pipe-C-HDMI-A-4
[325.810486] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.120s)
[325.821373] Starting dynamic subtest: pipe-D-HDMI-A-4
[325.932454] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.119s)
[325.933523] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.588s)
[326.075039] [094/142] (685s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[328.143365] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[328.144490] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.001s)
[328.349743] [095/142] (683s left) gem_exec_balancer (hang)
[328.637819] Starting subtest: hang
[330.748222] Subtest hang: SUCCESS (2.113s)
[330.877423] [096/142] (680s left) gen7_exec_parse (cmd-crossing-page)
[330.926374] Subtest cmd-crossing-page: SKIP (0.000s)
[330.957819] [097/142] (680s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[332.910726] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[332.913630] Starting dynamic subtest: pipe-A-valid-mode
[333.622127] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.709s)
[333.622990] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.711s)
[333.746462] [098/142] (678s left) gem_ctx_param (root-set)
[333.794791] Starting subtest: root-set
[333.795604] Subtest root-set: SUCCESS (0.001s)
[333.866235] [099/142] (678s left) syncobj_wait (multi-wait-for-submit-submitted)
[333.915582] Starting subtest: multi-wait-for-submit-submitted
[334.026309] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s)
[334.158050] [100/142] (677s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[334.208963] Starting subtest: multi-wait-for-submit-available-submitted
[334.209897] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[334.301176] [101/142] (677s left) syncobj_timeline (invalid-single-wait-all-available-unsubmitted)
[334.354807] Starting subtest: invalid-single-wait-all-available-unsubmitted
[334.355678] Subtest invalid-single-wait-all-available-unsubmitted: SUCCESS (0.000s)
[334.416370] [102/142] (677s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_mc_ccs)
[336.552517] Starting subtest: pipe-D-bad-aux-stride-y_tiled_gen12_mc_ccs
[336.556914] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[336.647713] [103/142] (675s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt)
[338.610451] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt
[340.950000] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (2.341s)
[341.100174] [104/142] (670s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[343.086144] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[343.088039] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[343.196195] [105/142] (668s left) vgem_basic (mmap)
[343.345287] Starting subtest: mmap
[343.364952] Subtest mmap: SUCCESS (0.020s)
[343.430490] [106/142] (668s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[345.414895] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[345.416828] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[345.505196] [107/142] (666s left) sysfs_timeslice_duration (invalid)
[345.653353] Starting subtest: invalid
[345.654683] Starting dynamic subtest: vecs0
[345.655994] Dynamic subtest vecs0: SUCCESS (0.001s)
[345.675737] Starting dynamic subtest: vcs0
[345.677088] Dynamic subtest vcs0: SUCCESS (0.001s)
[345.690745] Starting dynamic subtest: bcs0
[345.691878] Dynamic subtest bcs0: SUCCESS (0.001s)
[345.704372] Starting dynamic subtest: rcs0
[345.705474] Dynamic subtest rcs0: SUCCESS (0.001s)
[345.715325] Starting dynamic subtest: vcs1
[345.716533] Dynamic subtest vcs1: SUCCESS (0.001s)
[345.717776] Subtest invalid: SUCCESS (0.016s)
[345.745247] [108/142] (666s left) v3d/v3d_perfmon (get-values-invalid-pad)
[345.811152] Subtest get-values-invalid-pad: SKIP (0.000s)
[345.863953] [109/142] (666s left) gem_exec_balancer (nop)
[345.923193] Starting subtest: nop
[384.330866] Subtest nop: SUCCESS (38.408s)
[384.623689] [110/142] (627s left) kms_psr (dpms)
[384.672092] Subtest dpms: SKIP (0.000s)
[384.699950] [111/142] (627s left) kms_frontbuffer_tracking (psr-suspend)
[386.658530] Starting subtest: psr-suspend
[386.660536] Subtest psr-suspend: SKIP (0.000s)
[386.748981] [112/142] (625s left) kms_psr (psr2_sprite_blt)
[386.893538] Subtest psr2_sprite_blt: SKIP (0.000s)
[386.935720] [113/142] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[388.903920] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[388.906068] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[388.979822] [114/142] (623s left) kms_pm_dc (dc9-dpms)
[392.032784] Starting subtest: dc9-dpms
[392.546016] Subtest dc9-dpms: SUCCESS (0.513s)
[393.565401] [115/142] (618s left) kms_vblank (pipe-b-ts-continuation-idle)
[395.602695] Starting subtest: pipe-B-ts-continuation-idle
[395.877719] Subtest pipe-B-ts-continuation-idle: SUCCESS (0.276s)
[395.989770] [116/142] (616s left) gem_lmem_swapping (parallel-random)
[399.101897] Starting subtest: parallel-random
[399.102623] Starting dynamic subtest: lmem0
[400.072969] Dynamic subtest lmem0: SUCCESS (0.970s)
[400.073725] Subtest parallel-random: SUCCESS (0.971s)
[402.122203] [117/142] (610s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[406.465644] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[407.065463] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.599s)
[408.168917] [118/142] (604s left) gen3_render_linear_blits
[408.308552] [119/142] (604s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[408.358578] Starting subtest: single-wait-for-submit-unsubmitted
[408.464242] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[408.563736] [120/142] (603s left) kms_rotation_crc (sprite-rotation-270)
[410.540536] Starting subtest: sprite-rotation-270
[418.393444] Subtest sprite-rotation-270: SUCCESS (7.852s)
[418.578241] [121/142] (593s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[420.547298] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[420.549788] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[420.635330] [122/142] (591s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-a)
[422.672439] Starting subtest: universal-plane-pageflip-windowed-pipe-A
[423.254230] Subtest universal-plane-pageflip-windowed-pipe-A: SUCCESS (0.577s)
[423.401661] [123/142] (589s left) gem_exec_schedule (semaphore-codependency)
[423.710964] Starting subtest: semaphore-codependency
[423.735011] Subtest semaphore-codependency: SUCCESS (0.024s)
[424.014546] [124/142] (588s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_mc_ccs)
[426.056692] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs
[426.059985] Subtest pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[426.236378] [125/142] (586s left) gem_tiled_partial_pwrite_pread (reads)
[426.285428] Subtest reads: SKIP (0.000s)
[426.312525] [126/142] (586s left) kms_cursor_crc (cursor-onscreen-128x42)
[428.406162] Starting subtest: cursor-onscreen-128x42
[428.413162] Starting dynamic subtest: pipe-A-HDMI-A-4
[431.155199] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.742s)
[431.182882] Starting dynamic subtest: pipe-D-HDMI-A-4
[433.782247] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.607s)
[433.783294] Subtest cursor-onscreen-128x42: SUCCESS (5.376s)
[434.085074] [127/142] (578s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[436.178821] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[436.180852] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[436.318787] [128/142] (576s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_ccs)
[438.357896] Starting subtest: pipe-B-bad-pixel-format-y_tiled_ccs
[438.359767] Subtest pipe-B-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[438.554755] [129/142] (574s left) gem_workarounds (suspend-resume)
[438.616202] Starting subtest: suspend-resume
[459.729557] Subtest suspend-resume: SUCCESS (8.881s)
[463.880547] [130/142] (565s left) gem_exec_fence (long-history)
[464.279084] Starting subtest: long-history
[470.430076] Subtest long-history: SUCCESS (6.149s)
[470.748055] [131/142] (558s left) gem_spin_batch (legacy)
[470.805510] Starting subtest: legacy
[470.807894] Starting dynamic subtest: default
[474.150461] Dynamic subtest default: SUCCESS (3.337s)
[474.160353] Starting dynamic subtest: render
[477.381747] Dynamic subtest render: SUCCESS (3.225s)
[477.391332] Starting dynamic subtest: bsd
[480.711627] Dynamic subtest bsd: SUCCESS (3.324s)
[480.722020] Starting dynamic subtest: bsd1
[484.044100] Dynamic subtest bsd1: SUCCESS (3.325s)
[484.057245] Starting dynamic subtest: bsd2
[487.276519] Dynamic subtest bsd2: SUCCESS (3.229s)
[487.285104] Starting dynamic subtest: blt
[490.508281] Dynamic subtest blt: SUCCESS (3.225s)
[490.518196] Starting dynamic subtest: vebox
[493.741185] Dynamic subtest vebox: SUCCESS (3.226s)
[493.742746] Subtest legacy: SUCCESS (22.931s)
[493.957678] [132/142] (535s left) gem_ctx_persistence (heartbeat-hostile)
[494.008449] Starting subtest: heartbeat-hostile
[494.010615] Subtest heartbeat-hostile: SKIP (0.000s)
[494.076822] [133/142] (534s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[496.147719] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[496.148731] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s)
[496.321747] [134/142] (532s left) gem_lmem_swapping (verify-random-ccs)
[500.023605] Starting subtest: verify-random-ccs
[500.024373] Starting dynamic subtest: lmem0
[500.025758] Dynamic subtest lmem0: SKIP (0.000s)
[500.027231] Subtest verify-random-ccs: SKIP (0.001s)
[502.065861] [135/142] (527s left) vgem_basic (debugfs)
[502.113870] Starting subtest: debugfs
[502.114821] Subtest debugfs: SUCCESS (0.000s)
[502.129567] [136/142] (526s left) kms_color (ctm-0-50)
[508.105586] Starting subtest: ctm-0-50
[508.106555] Starting dynamic subtest: pipe-A
[509.660589] Dynamic subtest pipe-A: SUCCESS (1.554s)
[509.668555] Starting dynamic subtest: pipe-B
[510.968049] Dynamic subtest pipe-B: SUCCESS (1.306s)
[510.978416] Starting dynamic subtest: pipe-C
[512.323239] Dynamic subtest pipe-C: SUCCESS (1.354s)
[512.334999] Starting dynamic subtest: pipe-D
[513.653929] Dynamic subtest pipe-D: SUCCESS (1.329s)
[513.654927] Subtest ctm-0-50: SUCCESS (5.548s)
[513.758782] [137/142] (515s left) core_auth (getclient-master-drop)
[513.808886] Starting subtest: getclient-master-drop
[513.812091] Subtest getclient-master-drop: SUCCESS (0.003s)
[513.889711] [138/142] (515s left) gem_softpin (allocator-basic-reserve)
[513.966425] Starting subtest: allocator-basic-reserve
[514.179601] Subtest allocator-basic-reserve: SUCCESS (0.210s)
[514.307264] [139/142] (514s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[516.296495] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[516.298523] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[516.386058] [140/142] (512s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_ccs)
[518.610176] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_ccs
[518.612184] Subtest pipe-D-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[518.718957] [141/142] (510s left) gem_exec_schedule (deep)
[518.906777] Starting subtest: deep
[518.907648] Starting dynamic subtest: rcs0
[532.366639] Dynamic subtest rcs0: SUCCESS (13.459s)
[532.375163] Starting dynamic subtest: bcs0
[545.884177] Dynamic subtest bcs0: SUCCESS (13.516s)
[545.892795] Starting dynamic subtest: vcs0
[559.488908] Dynamic subtest vcs0: SUCCESS (13.603s)
[559.497543] Starting dynamic subtest: vcs1
[573.073138] Dynamic subtest vcs1: SUCCESS (13.583s)
[573.081980] Starting dynamic subtest: vecs0
[586.698223] Dynamic subtest vecs0: SUCCESS (13.624s)
[586.699120] Subtest deep: SUCCESS (67.792s)
[587.341360] [142/142] (441s left) gem_exec_fence (basic-wait-all)
[587.405333] Starting subtest: basic-wait-all
[587.494703] Subtest basic-wait-all: SUCCESS (0.089s)
[588.213685] Closing watchdogs
Done.