[38.666608] Initializing watchdogs
[38.666689]   /dev/watchdog0
[38.672525] [001/142] (960s left) i915_pm_freq_api (freq-suspend)
[38.758404] Starting subtest: freq-suspend
[38.759301] Starting dynamic subtest: gt0
[58.866009] Dynamic subtest gt0: SUCCESS (9.114s)
[58.866909] Subtest freq-suspend: SUCCESS (9.115s)
[63.930656] [002/142] (951s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[65.970035] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[65.971823] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[66.382727] [003/142] (948s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[68.364426] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[68.366456] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[68.448708] [004/142] (946s left) gem_eio (wait-wedge-immediate)
[68.625309] Starting subtest: wait-wedge-immediate
[70.242919] Subtest wait-wedge-immediate: SUCCESS (1.618s)
[72.217854] [005/142] (943s left) kms_ccs (pipe-b-ccs-on-another-bo-yf_tiled_ccs)
[74.373220] Starting subtest: pipe-B-ccs-on-another-bo-yf_tiled_ccs
[74.375524] Subtest pipe-B-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[74.661271] [006/142] (940s left) kms_getfb (getfb-reject-ccs)
[74.732036] Starting subtest: getfb-reject-ccs
[74.732889] Subtest getfb-reject-ccs: SUCCESS (0.000s)
[74.811275] [007/142] (940s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[76.786814] Starting subtest: cursor-vs-flip-toggle
[107.399101] Subtest cursor-vs-flip-toggle: SUCCESS (30.612s)
[107.518322] [008/142] (907s left) gem_lmem_swapping (parallel-random-verify)
[111.472092] Starting subtest: parallel-random-verify
[111.472909] Starting dynamic subtest: lmem0
[121.165336] Dynamic subtest lmem0: SUCCESS (9.690s)
[121.166422] Subtest parallel-random-verify: SUCCESS (9.690s)
[122.468534] [009/142] (892s left) i915_pm_rpm (gem-execbuf)
[129.487920] Starting subtest: gem-execbuf
[129.490465] Starting dynamic subtest: lmem0
[138.242884] Dynamic subtest lmem0: SUCCESS (8.758s)
[138.252540] Starting dynamic subtest: smem0
[149.166607] Dynamic subtest smem0: SUCCESS (10.924s)
[149.167398] Subtest gem-execbuf: SUCCESS (19.683s)
[152.214730] [010/142] (863s left) v3d/v3d_create_bo (create-bo-0)
[152.315348] Subtest create-bo-0: SKIP (0.000s)
[152.364390] [011/142] (862s left) gem_exec_reloc (basic-cpu-active)
[152.440084] Subtest basic-cpu-active: SKIP (0.000s)
[152.489714] [012/142] (862s left) kms_chamelium_frames (hdmi-crc-multiple)
[154.525112] Subtest hdmi-crc-multiple: SKIP (0.000s)
[154.586094] [013/142] (860s left) perf (non-system-wide-paranoid)
[154.715169] Starting subtest: non-system-wide-paranoid
[154.759402] Subtest non-system-wide-paranoid: SUCCESS (0.044s)
[154.787030] [014/142] (860s left) syncobj_timeline (multi-wait-all-available-signaled)
[154.858254] Starting subtest: multi-wait-all-available-signaled
[154.859209] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[154.921501] [015/142] (860s left) kms_content_protection (srm)
[156.940396] Starting subtest: srm
[157.207079] Subtest srm: SKIP (0.264s)
[157.358308] [016/142] (858s left) gem_close (many-handles-one-vma)
[157.431317] Starting subtest: many-handles-one-vma
[157.461401] Subtest many-handles-one-vma: SUCCESS (0.030s)
[157.558138] [017/142] (857s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[159.542656] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[159.544672] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[159.624989] [018/142] (855s left) gem_softpin (allocator-fork)
[159.726594] Starting subtest: allocator-fork
[162.025557] Subtest allocator-fork: SUCCESS (2.296s)
[162.182242] [019/142] (853s left) syncobj_timeline (reset-signaled)
[162.271147] Starting subtest: reset-signaled
[162.272127] Subtest reset-signaled: SUCCESS (0.000s)
[162.323534] [020/142] (853s left) kms_addfb_basic (unused-pitches)
[162.395212] Starting subtest: unused-pitches
[162.396061] Subtest unused-pitches: SUCCESS (0.000s)
[164.373548] [021/142] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[166.365132] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[166.367032] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[166.440215] [022/142] (849s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[168.438694] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[168.440788] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[168.523805] [023/142] (847s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_ccs)
[170.861618] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_ccs
[170.863743] Subtest pipe-D-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[170.990686] [024/142] (844s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[171.062225] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[171.063336] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[171.123818] [025/142] (844s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[173.147432] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[173.233444] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.086s)
[173.730317] [026/142] (841s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[175.712216] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[175.714156] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[175.796653] [027/142] (839s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[177.968688] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[178.079949] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SUCCESS (0.111s)
[178.421376] [028/142] (837s left) gem_mmap_gtt (basic-small-copy)
[178.492096] Subtest basic-small-copy: SKIP (0.000s)
[178.512867] [029/142] (837s left) kms_ccs (pipe-d-bad-rotation-90-yf_tiled_ccs)
[180.787936] Starting subtest: pipe-D-bad-rotation-90-yf_tiled_ccs
[180.793196] Subtest pipe-D-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[180.957353] [030/142] (834s left) kms_vblank (pipe-b-wait-forked)
[182.937792] Starting subtest: pipe-B-wait-forked
[185.582520] Subtest pipe-B-wait-forked: SUCCESS (2.647s)
[185.694991] [031/142] (830s left) kms_lease (lease-uevent)
[187.671716] Starting subtest: lease-uevent
[188.689881] Subtest lease-uevent: SUCCESS (1.015s)
[188.744690] [032/142] (826s left) kms_flip (flip-vs-rmfb-interruptible)
[189.781033] Starting subtest: flip-vs-rmfb-interruptible
[189.792642] Starting dynamic subtest: A-HDMI-A4
[197.521647] Dynamic subtest A-HDMI-A4: SUCCESS (7.729s)
[197.529497] Starting dynamic subtest: B-HDMI-A4
[205.215254] Dynamic subtest B-HDMI-A4: SUCCESS (7.693s)
[205.223687] Starting dynamic subtest: C-HDMI-A4
[212.904466] Dynamic subtest C-HDMI-A4: SUCCESS (7.688s)
[212.913333] Starting dynamic subtest: D-HDMI-A4
[220.587636] Dynamic subtest D-HDMI-A4: SUCCESS (7.682s)
[220.588730] Subtest flip-vs-rmfb-interruptible: SUCCESS (30.807s)
[220.728218] [033/142] (794s left) gem_exec_fair (basic-none-share)
[220.809951] Subtest basic-none-share: SKIP (0.000s)
[220.852271] [034/142] (794s left) kms_flip (modeset-vs-vblank-race-interruptible)
[221.880049] Starting subtest: modeset-vs-vblank-race-interruptible
[221.891757] Starting dynamic subtest: A-HDMI-A4
[225.002353] Dynamic subtest A-HDMI-A4: SUCCESS (3.110s)
[225.011421] Starting dynamic subtest: B-HDMI-A4
[227.961663] Dynamic subtest B-HDMI-A4: SUCCESS (2.958s)
[227.970247] Starting dynamic subtest: C-HDMI-A4
[230.958853] Dynamic subtest C-HDMI-A4: SUCCESS (2.996s)
[230.967582] Starting dynamic subtest: D-HDMI-A4
[233.938900] Dynamic subtest D-HDMI-A4: SUCCESS (2.979s)
[233.939822] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.059s)
[234.079244] [035/142] (781s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[236.070679] Starting subtest: x-tiled-16bpp-rotate-90
[236.147754] Subtest x-tiled-16bpp-rotate-90: SKIP (0.076s)
[236.245108] [036/142] (779s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[238.226882] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[238.228634] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[238.311536] [037/142] (777s left) kms_prop_blob (blob-prop-lifetime)
[238.381141] Starting subtest: blob-prop-lifetime
[238.383463] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[238.444635] [038/142] (777s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[240.427662] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[240.429818] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[240.511615] [039/142] (775s left) perf (whitelisted-registers-userspace-config)
[240.630933] Starting subtest: whitelisted-registers-userspace-config
[240.632054] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[240.660740] [040/142] (775s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[242.853359] Starting subtest: cursor-rapid-movement-512x170
[242.856815] Subtest cursor-rapid-movement-512x170: SKIP (0.002s)
[242.994112] [041/142] (772s left) kms_lease (lease_unleased_crtc)
[244.973295] Starting subtest: lease_unleased_crtc
[244.974454] Starting dynamic subtest: pipe-A-HDMI-A-4
[245.049518] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.076s)
[245.062675] Starting dynamic subtest: pipe-B-HDMI-A-4
[245.116620] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.065s)
[245.127841] Starting dynamic subtest: pipe-C-HDMI-A-4
[245.182491] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.064s)
[245.191204] Starting dynamic subtest: pipe-D-HDMI-A-4
[245.249165] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.064s)
[245.250687] Subtest lease_unleased_crtc: SUCCESS (0.277s)
[245.340786] [042/142] (770s left) prime_mmap (test_map_unmap)
[245.410357] Starting subtest: test_map_unmap
[245.411145] Starting dynamic subtest: test_map_unmap-smem
[245.501769] Dynamic subtest test_map_unmap-smem: SUCCESS (0.091s)
[245.508607] Starting dynamic subtest: test_map_unmap-lmem0
[245.593645] Dynamic subtest test_map_unmap-lmem0: SUCCESS (0.091s)
[245.594506] Subtest test_map_unmap: SUCCESS (0.184s)
[245.674086] [043/142] (770s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[245.744203] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[247.740681] [044/142] (768s left) gem_vm_create (invalid-destroy)
[247.850475] Starting subtest: invalid-destroy
[247.853118] Subtest invalid-destroy: SUCCESS (0.002s)
[247.926483] [045/142] (767s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[249.921821] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[249.923755] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[250.007290] [046/142] (765s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[252.024554] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[252.026214] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[252.106023] [047/142] (763s left) kms_universal_plane (cursor-fb-leak-pipe-b)
[254.114335] Starting subtest: cursor-fb-leak-pipe-B
[254.970266] Subtest cursor-fb-leak-pipe-B: SUCCESS (0.853s)
[255.208677] [048/142] (760s left) gem_tiled_fence_blits (basic)
[255.399008] Subtest basic: SKIP (0.000s)
[255.477424] [049/142] (760s left) gem_lmem_swapping (verify-random-ccs)
[259.190793] Starting subtest: verify-random-ccs
[259.191641] Starting dynamic subtest: lmem0
[259.193239] Dynamic subtest lmem0: SKIP (0.000s)
[259.195183] Subtest verify-random-ccs: SKIP (0.001s)
[261.350339] [050/142] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[266.650427] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[266.652639] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[266.721720] [051/142] (749s left) api_intel_allocator (reopen)
[266.807138] Starting subtest: reopen
[266.824548] Subtest reopen: SUCCESS (0.018s)
[266.953548] [052/142] (749s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[268.949004] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[268.951893] Starting dynamic subtest: pipe-A-valid-mode
[269.001082] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s)
[269.003181] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.050s)
[269.092739] [053/142] (747s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[271.338527] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[271.340486] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[271.555345] [054/142] (744s left) sw_sync (sync_merge_invalid)
[271.624031] Starting subtest: sync_merge_invalid
[271.627296] Subtest sync_merge_invalid: SUCCESS (0.003s)
[271.655970] [055/142] (744s left) kms_frontbuffer_tracking (fbc-1p-rte)
[273.637813] Starting subtest: fbc-1p-rte
[278.467505] Subtest fbc-1p-rte: SUCCESS (4.833s)
[278.618565] [056/142] (737s left) kms_psr (psr2_no_drrs)
[278.694577] Subtest psr2_no_drrs: SKIP (0.000s)
[278.726165] [057/142] (737s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[280.699849] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[280.702992] Starting dynamic subtest: pipe-A-HDMI-A-4
[280.839984] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.138s)
[280.848313] Starting dynamic subtest: pipe-B-HDMI-A-4
[280.961920] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.119s)
[280.970218] Starting dynamic subtest: pipe-C-HDMI-A-4
[281.084757] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.120s)
[281.093114] Starting dynamic subtest: pipe-D-HDMI-A-4
[281.207817] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.120s)
[281.208903] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.508s)
[281.346724] [058/142] (734s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs)
[283.533020] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs
[283.535479] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[283.798595] [059/142] (732s left) v3d/v3d_wait_bo (used-bo)
[283.898670] Subtest used-bo: SKIP (0.000s)
[283.948238] [060/142] (732s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[285.931918] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[285.934137] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[286.014952] [061/142] (730s left) syncobj_timeline (wait-any-complex)
[286.112353] Starting subtest: wait-any-complex
[286.175284] Subtest wait-any-complex: SUCCESS (0.063s)
[286.286053] [062/142] (730s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[288.491907] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[288.496104] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.003s)
[288.772233] [063/142] (727s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[290.750029] Starting subtest: cursorB-vs-flipA-atomic
[290.753056] Subtest cursorB-vs-flipA-atomic: SKIP (0.004s)
[290.820936] [064/142] (725s left) kms_big_joiner (basic)
[292.808996] Subtest basic: SKIP (0.000s)
[292.830587] [065/142] (723s left) gem_render_tiled_blits (basic)
[292.907597] Subtest basic: SKIP (0.000s)
[292.930255] [066/142] (723s left) gem_exec_reloc (basic-gtt-active)
[293.007258] Subtest basic-gtt-active: SKIP (0.000s)
[293.045974] [067/142] (723s left) gem_userptr_blits (coherency-unsync)
[293.136420] Subtest coherency-unsync: SKIP (0.000s)
[293.312004] [068/142] (723s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[295.346846] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[295.404600] [069/142] (721s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[295.482355] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[295.483323] Starting dynamic subtest: smem
[295.576610] Dynamic subtest smem: SUCCESS (0.094s)
[295.583687] Starting dynamic subtest: lmem0
[296.683312] Dynamic subtest lmem0: SUCCESS (1.103s)
[296.684288] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (1.199s)
[296.903285] [070/142] (719s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[299.077330] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[299.078097] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.001s)
[299.364677] [071/142] (717s left) perf_pmu (semaphore-wait-idle)
[299.437919] Starting subtest: semaphore-wait-idle
[299.438798] Starting dynamic subtest: rcs0
[299.966749] Dynamic subtest rcs0: SUCCESS (0.524s)
[299.974212] Starting dynamic subtest: bcs0
[300.480521] Dynamic subtest bcs0: SUCCESS (0.509s)
[300.487982] Starting dynamic subtest: vcs0
[300.994471] Dynamic subtest vcs0: SUCCESS (0.509s)
[301.002085] Starting dynamic subtest: vcs1
[301.508654] Dynamic subtest vcs1: SUCCESS (0.509s)
[301.516017] Starting dynamic subtest: vecs0
[302.022636] Dynamic subtest vecs0: SUCCESS (0.509s)
[302.023503] Subtest semaphore-wait-idle: SUCCESS (2.584s)
[302.157969] [072/142] (714s left) drm_fdinfo (most-busy-idle-check-all)
[302.229727] Starting subtest: most-busy-idle-check-all
[302.230638] Starting dynamic subtest: rcs0
[302.244423] Dynamic subtest rcs0: SKIP (0.013s)
[302.252373] Starting dynamic subtest: bcs0
[302.254670] Dynamic subtest bcs0: SKIP (0.000s)
[302.261862] Starting dynamic subtest: vcs0
[302.263776] Dynamic subtest vcs0: SKIP (0.000s)
[302.271039] Starting dynamic subtest: vcs1
[302.273359] Dynamic subtest vcs1: SKIP (0.000s)
[302.280617] Starting dynamic subtest: vecs0
[302.282959] Dynamic subtest vecs0: SKIP (0.000s)
[302.285301] Subtest most-busy-idle-check-all: SKIP (0.020s)
[302.314227] [073/142] (714s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[302.414168] Subtest bad-multisync-out-sync: SKIP (0.000s)
[302.471127] [074/142] (714s left) kms_selftest (drm_damage)
[302.541954] Starting subtest: drm_damage
[302.545268] Subtest drm_damage: SKIP (0.001s)
[302.604208] [075/142] (714s left) kms_atomic (test-only)
[304.842376] Starting subtest: test-only
[305.304080] Subtest test-only: SUCCESS (0.462s)
[305.428019] [076/142] (711s left) gem_exec_schedule (preempt-queue-contexts-chain)
[305.511469] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[305.803616] [077/142] (710s left) kms_vblank (pipe-d-query-idle)
[307.779111] Starting subtest: pipe-D-query-idle
[311.181313] Subtest pipe-D-query-idle: SUCCESS (3.402s)
[311.295501] [078/142] (705s left) kms_chamelium_color (ctm-0-75)
[313.274243] Subtest ctm-0-75: SKIP (0.000s)
[313.304126] [079/142] (703s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[315.529643] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[315.531884] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[315.746915] [080/142] (700s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[317.725303] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[320.234357] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (2.511s)
[320.346599] [081/142] (696s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[322.327340] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[322.329353] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[322.412922] [082/142] (694s left) gen9_exec_parse (bb-start-out)
[322.513087] Subtest bb-start-out: SKIP (0.000s)
[322.537805] [083/142] (694s left) perf_pmu (busy-double-start)
[322.608584] Starting subtest: busy-double-start
[322.609496] Starting dynamic subtest: rcs0
[326.209098] Dynamic subtest rcs0: FAIL (3.583s)
[326.217859] Starting dynamic subtest: bcs0
[329.780369] Dynamic subtest bcs0: SUCCESS (3.587s)
[329.791786] Starting dynamic subtest: vcs0
[333.370481] Dynamic subtest vcs0: SUCCESS (3.588s)
[333.382622] Starting dynamic subtest: vcs1
[336.949370] Dynamic subtest vcs1: SUCCESS (3.577s)
[336.959705] Starting dynamic subtest: vecs0
[340.515360] Dynamic subtest vecs0: SUCCESS (3.565s)
[340.516326] Subtest busy-double-start: FAIL (17.907s)
[340.622342] [084/142] (676s left) i915_module_load (load)
[340.688137] Starting subtest: load
[340.689905] Subtest load: SKIP (0.001s)
[340.747140] [085/142] (676s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[342.736032] Starting subtest: y-tiled-64bpp-rotate-270
[342.789846] Subtest y-tiled-64bpp-rotate-270: SKIP (0.053s)
[342.893479] [086/142] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[344.876407] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[344.878548] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[344.959840] [087/142] (671s left) gem_exec_schedule (u-submit-late-slice)
[345.065608] Starting subtest: u-submit-late-slice
[345.066750] Starting dynamic subtest: rcs0
[345.116738] Dynamic subtest rcs0: SUCCESS (0.051s)
[345.125508] Starting dynamic subtest: bcs0
[345.151164] Dynamic subtest bcs0: SUCCESS (0.033s)
[345.158961] Starting dynamic subtest: vcs0
[345.185444] Dynamic subtest vcs0: SUCCESS (0.033s)
[345.194320] Starting dynamic subtest: vcs1
[345.233911] Dynamic subtest vcs1: SUCCESS (0.047s)
[345.244430] Starting dynamic subtest: vecs0
[345.271316] Dynamic subtest vecs0: SUCCESS (0.036s)
[345.272163] Subtest u-submit-late-slice: SUCCESS (0.206s)
[345.621902] [088/142] (671s left) gem_eio (throttle)
[345.848969] Starting subtest: throttle
[346.129405] Subtest throttle: SUCCESS (0.281s)
[348.109769] [089/142] (668s left) gem_exec_reloc (basic-wc)
[348.196554] Subtest basic-wc: SKIP (0.000s)
[348.251312] [090/142] (668s left) gem_ctx_engines (independent)
[348.331566] Starting subtest: independent
[348.332491] Starting dynamic subtest: rcs0
[348.488551] Dynamic subtest rcs0: SUCCESS (0.153s)
[348.496378] Starting dynamic subtest: bcs0
[348.636351] Dynamic subtest bcs0: SUCCESS (0.147s)
[348.644280] Starting dynamic subtest: vcs0
[348.790494] Dynamic subtest vcs0: SUCCESS (0.152s)
[348.798350] Starting dynamic subtest: vcs1
[348.941605] Dynamic subtest vcs1: SUCCESS (0.150s)
[348.949580] Starting dynamic subtest: vecs0
[349.094731] Dynamic subtest vecs0: SUCCESS (0.152s)
[349.102738] Starting dynamic subtest: all-engines
[349.335990] Dynamic subtest all-engines: SUCCESS (0.240s)
[349.336856] Subtest independent: SUCCESS (1.002s)
[349.899879] [091/142] (667s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[351.878687] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[353.457965] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.579s)
[353.576453] [092/142] (663s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[355.555199] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[355.556264] Starting dynamic subtest: pipe-A-valid-mode
[356.592936] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.037s)
[356.594087] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.040s)
[356.719111] [093/142] (660s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[358.694958] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[358.697072] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[358.768205] [094/142] (658s left) kms_addfb_basic (small-bo)
[360.744404] Starting subtest: small-bo
[360.745458] Subtest small-bo: SUCCESS (0.000s)
[360.834943] [095/142] (656s left) gem_eio (wait-wedge-10ms)
[361.050710] Starting subtest: wait-wedge-10ms
[362.269668] Subtest wait-wedge-10ms: SUCCESS (1.219s)
[364.250579] [096/142] (652s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[366.254928] Starting subtest: plane-all-modeset-transition-internal-panels
[366.257007] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[366.317440] [097/142] (650s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[368.296026] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[368.297874] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[368.383953] [098/142] (648s left) gem_mmap_offset (bad-object)
[368.479011] Starting subtest: bad-object
[368.479929] Subtest bad-object: SUCCESS (0.001s)
[368.590268] [099/142] (648s left) i915_pm_rpm (universal-planes-dpms)
[373.478596] Starting subtest: universal-planes-dpms
[373.483493] Starting dynamic subtest: plane-31
[391.532441] Dynamic subtest plane-31: SUCCESS (18.052s)
[391.603026] Starting dynamic subtest: plane-40
[408.155366] Dynamic subtest plane-40: SUCCESS (16.567s)
[408.214083] Starting dynamic subtest: plane-49
[430.621345] Dynamic subtest plane-49: SUCCESS (22.416s)
[430.673853] Starting dynamic subtest: plane-58
[441.204282] Dynamic subtest plane-58: SUCCESS (10.539s)
[442.204226] Starting dynamic subtest: plane-67
[455.498074] Dynamic subtest plane-67: SUCCESS (13.303s)
[455.566531] Starting dynamic subtest: plane-76
[464.918890] Dynamic subtest plane-76: SUCCESS (9.365s)
[464.974308] Starting dynamic subtest: plane-85
[480.514374] Dynamic subtest plane-85: SUCCESS (15.551s)
[481.518395] Starting dynamic subtest: plane-94
[498.191924] Dynamic subtest plane-94: SUCCESS (16.684s)
[498.192979] Subtest universal-planes-dpms: SUCCESS (124.715s)
[500.313322] [100/142] (516s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[500.918855] Starting subtest: syncobj-timeline-invalid-flags
[500.920003] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[501.157430] [101/142] (515s left) gem_exec_reloc (basic-gtt-read-active)
[501.228686] Subtest basic-gtt-read-active: SKIP (0.000s)
[501.271147] [102/142] (515s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_mc_ccs)
[503.316171] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs
[503.319624] Subtest pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[503.719342] [103/142] (513s left) vgem_basic (bad-flag)
[503.801172] Starting subtest: bad-flag
[503.802109] Subtest bad-flag: SUCCESS (0.000s)
[503.852750] [104/142] (513s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[505.836352] Starting subtest: yf-tiled-16bpp-rotate-270
[505.840664] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[505.920067] [105/142] (511s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[508.326225] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[508.330056] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.003s)
[508.432249] [106/142] (508s left) kms_plane_multiple (tiling-none)
[510.406045] Starting subtest: tiling-none
[510.409076] Starting dynamic subtest: pipe-A-HDMI-A-4
[511.137543] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.730s)
[511.147409] Starting dynamic subtest: pipe-B-HDMI-A-4
[511.821649] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.682s)
[511.838076] Starting dynamic subtest: pipe-C-HDMI-A-4
[512.443313] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.620s)
[512.454034] Starting dynamic subtest: pipe-D-HDMI-A-4
[513.070979] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.625s)
[513.071876] Subtest tiling-none: SUCCESS (2.666s)
[513.198128] [107/142] (504s left) syncobj_timeline (32bits-limit)
[513.269670] Starting subtest: 32bits-limit
[513.270524] Subtest 32bits-limit: SUCCESS (0.001s)
[513.331757] [108/142] (503s left) gem_madvise (dontneed-after-mmap)
[513.399653] Starting subtest: dontneed-after-mmap
[513.403037] Subtest dontneed-after-mmap: SUCCESS (0.003s)
[513.481335] [109/142] (503s left) syncobj_wait (invalid-signal-bad-pad)
[513.552748] Starting subtest: invalid-signal-bad-pad
[513.553699] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[513.614604] [110/142] (503s left) kms_universal_plane (universal-plane-pipe-a-functional)
[515.591048] Starting subtest: universal-plane-pipe-A-functional
[517.659445] Subtest universal-plane-pipe-A-functional: SUCCESS (2.070s)
[517.781498] [111/142] (499s left) gem_userptr_blits (stress-purge)
[517.865077] Starting subtest: stress-purge
[523.249981] Subtest stress-purge: SUCCESS (5.385s)
[523.389033] [112/142] (493s left) kms_flip (flip-vs-panning-interruptible)
[524.484159] Starting subtest: flip-vs-panning-interruptible
[524.495895] Starting dynamic subtest: A-HDMI-A4
[532.355540] Dynamic subtest A-HDMI-A4: SUCCESS (7.860s)
[532.369315] Starting dynamic subtest: B-HDMI-A4
[540.068038] Dynamic subtest B-HDMI-A4: SUCCESS (7.710s)
[540.081985] Starting dynamic subtest: C-HDMI-A4
[547.773769] Dynamic subtest C-HDMI-A4: SUCCESS (7.704s)
[547.785295] Starting dynamic subtest: D-HDMI-A4
[555.473232] Dynamic subtest D-HDMI-A4: SUCCESS (7.698s)
[555.474412] Subtest flip-vs-panning-interruptible: SUCCESS (30.990s)
[555.615800] [113/142] (461s left) kms_setmode (invalid-clone-single-crtc-stealing)
[555.686776] Starting subtest: invalid-clone-single-crtc-stealing
[555.689792] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[555.747646] [114/142] (461s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[557.735594] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[557.737702] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[557.813751] [115/142] (459s left) v3d/v3d_submit_cl (bad-pad)
[557.946030] Subtest bad-pad: SKIP (0.000s)
[557.997164] [116/142] (459s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[560.220797] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[560.331061] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.110s)
[560.574681] [117/142] (456s left) api_intel_bb (full-batch)
[560.644170] Starting subtest: full-batch
[560.658055] Subtest full-batch: SUCCESS (0.014s)
[560.741309] [118/142] (456s left) gem_exec_schedule (implicit-read-write)
[560.822591] Starting subtest: implicit-read-write
[560.823504] Starting dynamic subtest: rcs0
[561.006075] Dynamic subtest rcs0: SUCCESS (0.181s)
[561.016608] Starting dynamic subtest: bcs0
[561.129472] Dynamic subtest bcs0: SUCCESS (0.123s)
[561.148674] Starting dynamic subtest: vcs0
[561.269755] Dynamic subtest vcs0: SUCCESS (0.126s)
[561.297713] Starting dynamic subtest: vcs1
[561.388249] Dynamic subtest vcs1: SUCCESS (0.125s)
[561.411345] Starting dynamic subtest: vecs0
[561.527289] Dynamic subtest vecs0: SUCCESS (0.135s)
[561.547690] Subtest implicit-read-write: SUCCESS (0.694s)
[561.959662] [119/142] (455s left) dumb_buffer (create-clear)
[562.044651] Starting subtest: create-clear
[598.908704] Subtest create-clear: SUCCESS (36.862s)
[599.053310] [120/142] (418s left) gem_ctx_persistence (process)
[599.126023] Starting subtest: process
[599.245247] Subtest process: SUCCESS (0.118s)
[599.388543] [121/142] (418s left) debugfs_test (sysfs)
[599.469421] Starting subtest: sysfs
[599.628357] Subtest sysfs: SUCCESS (0.158s)
[601.602044] [122/142] (415s left) kms_flip (flip-vs-wf_vblank-interruptible)
[602.641566] Starting subtest: flip-vs-wf_vblank-interruptible
[602.653357] Starting dynamic subtest: A-HDMI-A4
[603.661726] Dynamic subtest A-HDMI-A4: SUCCESS (1.008s)
[603.672601] Starting dynamic subtest: B-HDMI-A4
[604.607557] Dynamic subtest B-HDMI-A4: SUCCESS (0.945s)
[604.618339] Starting dynamic subtest: C-HDMI-A4
[605.547804] Dynamic subtest C-HDMI-A4: SUCCESS (0.939s)
[605.558698] Starting dynamic subtest: D-HDMI-A4
[606.484394] Dynamic subtest D-HDMI-A4: SUCCESS (0.934s)
[606.486809] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (3.844s)
[606.625385] [123/142] (410s left) kms_flip (flip-vs-panning-vs-hang)
[607.651627] Starting subtest: flip-vs-panning-vs-hang
[607.656859] Starting dynamic subtest: A-HDMI-A4
[645.841646] Dynamic subtest A-HDMI-A4: SUCCESS (38.185s)
[645.852922] Starting dynamic subtest: D-HDMI-A4
[695.862364] Dynamic subtest D-HDMI-A4: SUCCESS (50.020s)
[695.863158] Subtest flip-vs-panning-vs-hang: SUCCESS (88.212s)
[695.987726] [124/142] (321s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[697.977639] Starting subtest: x-tiled-32bpp-rotate-180
[699.871418] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.890s)
[700.007473] [125/142] (317s left) kms_psr (suspend)
[700.089424] Subtest suspend: SKIP (0.000s)
[700.111518] [126/142] (317s left) sw_sync (sync_multi_consumer)
[700.178712] Starting subtest: sync_multi_consumer
[700.529302] Subtest sync_multi_consumer: SUCCESS (0.347s)
[700.570435] [127/142] (317s left) vc4/vc4_perfmon (create-perfmon-invalid-events)
[700.667629] Subtest create-perfmon-invalid-events: SKIP (0.000s)
[700.721006] [128/142] (316s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[702.703259] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[702.705284] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[702.786657] [129/142] (314s left) kms_cursor_crc (cursor-random-256x85)
[704.980432] Starting subtest: cursor-random-256x85
[704.987647] Starting dynamic subtest: pipe-A-HDMI-A-4
[709.521451] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.534s)
[709.552319] Starting dynamic subtest: pipe-D-HDMI-A-4
[715.044936] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (5.503s)
[715.046007] Subtest cursor-random-256x85: SUCCESS (10.065s)
[715.289448] [130/142] (302s left) kms_flip (basic-flip-vs-dpms)
[716.317330] Starting subtest: basic-flip-vs-dpms
[716.327189] Starting dynamic subtest: A-HDMI-A4
[717.111017] Dynamic subtest A-HDMI-A4: SUCCESS (0.782s)
[717.120284] Starting dynamic subtest: B-HDMI-A4
[717.742460] Dynamic subtest B-HDMI-A4: SUCCESS (0.631s)
[717.752556] Starting dynamic subtest: C-HDMI-A4
[718.433755] Dynamic subtest C-HDMI-A4: SUCCESS (0.690s)
[718.443282] Starting dynamic subtest: D-HDMI-A4
[719.091337] Dynamic subtest D-HDMI-A4: SUCCESS (0.657s)
[719.092220] Subtest basic-flip-vs-dpms: SUCCESS (2.776s)
[719.226731] [131/142] (298s left) kms_flip (2x-flip-vs-suspend-interruptible)
[720.259436] Starting subtest: 2x-flip-vs-suspend-interruptible
[720.285772] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.025s)
[720.359500] [132/142] (297s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[722.341680] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[725.071073] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.733s)
[725.191695] [133/142] (292s left) gem_create (create-clear)
[725.261298] Starting subtest: create-clear
[725.262140] Starting dynamic subtest: lmem0
[757.703453] Dynamic subtest lmem0: SUCCESS (32.439s)
[757.713309] Starting dynamic subtest: smem0
[792.576550] Dynamic subtest smem0: SUCCESS (34.867s)
[792.577525] Subtest create-clear: SUCCESS (67.307s)
[795.009156] [134/142] (222s left) gem_exec_balancer (invalid-balancer)
[795.094693] Starting subtest: invalid-balancer
[796.328433] Subtest invalid-balancer: SUCCESS (1.231s)
[796.632924] [135/142] (221s left) gem_mmap_gtt (basic-write-gtt)
[796.703625] Subtest basic-write-gtt: SKIP (0.000s)
[796.739217] [136/142] (221s left) gem_pwrite (basic-self)
[796.809347] Subtest basic-self: SKIP (0.000s)
[796.859660] [137/142] (220s left) kms_plane_scaling (planes-downscale-factor-0-25)
[798.839015] Starting subtest: planes-downscale-factor-0-25
[798.841940] Starting dynamic subtest: pipe-A-HDMI-A-4
[798.855700] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.013s)
[798.865497] Starting dynamic subtest: pipe-B-HDMI-A-4
[798.881378] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.022s)
[798.890966] Starting dynamic subtest: pipe-C-HDMI-A-4
[798.904715] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.022s)
[798.915952] Starting dynamic subtest: pipe-D-HDMI-A-4
[798.930292] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.023s)
[798.932354] Subtest planes-downscale-factor-0-25: SKIP (0.091s)
[799.014945] [138/142] (218s left) gem_exec_balancer (full-late)
[799.093710] Starting subtest: full-late
[800.575059] Subtest full-late: SUCCESS (1.481s)
[800.902552] [139/142] (216s left) gem_ctx_persistence (heartbeat-many)
[800.974319] Starting subtest: heartbeat-many
[800.976387] Subtest heartbeat-many: SKIP (0.000s)
[801.081019] [140/142] (216s left) gem_exec_whisper (basic-contexts-forked-all)
[801.185740] Starting subtest: basic-contexts-forked-all
[825.133830] Subtest basic-contexts-forked-all: SUCCESS (23.944s)
[825.329715] [141/142] (192s left) kms_writeback (writeback-invalid-parameters)
[829.210550] Subtest writeback-invalid-parameters: SKIP (0.000s)
[829.236001] [142/142] (188s left) kms_cursor_edge_walk (64x64-left-edge)
[831.276870] Starting subtest: 64x64-left-edge
[831.279958] Starting dynamic subtest: pipe-A-HDMI-A-4
[834.595368] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.315s)
[834.610674] Starting dynamic subtest: pipe-D-HDMI-A-4
[837.802790] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (3.205s)
[837.804316] Subtest 64x64-left-edge: SUCCESS (6.526s)
[837.931761] Closing watchdogs
Done.