[50.419402] Initializing watchdogs
[50.419562]   /dev/watchdog0
[50.434118] [001/142] (960s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[50.986241] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[50.990055] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[51.812598] [002/142] (959s left) syncobj_timeline (device-submit-unordered)
[51.916948] Starting subtest: device-submit-unordered
[51.918556] Subtest device-submit-unordered: SUCCESS (0.001s)
[51.986043] [003/142] (958s left) kms_ccs (pipe-a-bad-pixel-format-yf_tiled_ccs)
[52.129465] Starting subtest: pipe-A-bad-pixel-format-yf_tiled_ccs
[52.132307] Subtest pipe-A-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[53.330250] [004/142] (957s left) gem_exec_fence (submit-chain)
[53.588690] Starting subtest: submit-chain
[53.625426] Subtest submit-chain: SUCCESS (0.039s)
[55.535907] [005/142] (955s left) perf (gen12-oa-tlb-invalidate)
[55.848672] Starting subtest: gen12-oa-tlb-invalidate
[55.850140] Starting dynamic subtest: 0-rcs0
[65.898833] Dynamic subtest 0-rcs0: SUCCESS (10.046s)
[65.915388] Starting dynamic subtest: 1-vcs1
[75.939519] Dynamic subtest 1-vcs1: SUCCESS (10.041s)
[75.944508] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.088s)
[75.983767] [006/142] (935s left) gem_busy (close-race)
[76.103471] Starting subtest: close-race
[100.454607] Subtest close-race: SUCCESS (24.350s)
[100.828419] [007/142] (910s left) i915_pm_rps (waitboost)
[101.017693] Starting subtest: waitboost
[101.057836] Subtest waitboost: FAIL (0.026s)
[101.091678] [008/142] (910s left) gem_eio (in-flight-internal-immediate)
[101.582070] Starting subtest: in-flight-internal-immediate
[102.711384] Subtest in-flight-internal-immediate: SUCCESS (1.132s)
[104.469896] [009/142] (906s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[104.963341] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[104.966476] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[105.829881] [010/142] (905s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[105.974054] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[105.975998] Starting dynamic subtest: pipe-A-default-mode
[106.287118] Dynamic subtest pipe-A-default-mode: SKIP (0.310s)
[106.290057] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.313s)
[107.197971] [011/142] (904s left) i915_module_load (reload-with-fault-injection)
[107.295296] Starting subtest: reload-with-fault-injection
[140.273977] Subtest reload-with-fault-injection: SUCCESS (32.977s)
[140.299667] [012/142] (870s left) prime_self_import (export-vs-gem_close-race)
[140.393493] Starting subtest: export-vs-gem_close-race
[147.142254] Subtest export-vs-gem_close-race: SUCCESS (6.746s)
[147.202454] [013/142] (864s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[147.386876] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[149.109122] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.722s)
[149.402688] [014/142] (861s left) api_intel_bb (bb-with-allocator)
[149.497513] Starting subtest: bb-with-allocator
[149.501495] Subtest bb-with-allocator: SUCCESS (0.005s)
[149.609891] [015/142] (861s left) kms_chamelium_color (ctm-0-25)
[149.754584] Subtest ctm-0-25: SKIP (0.000s)
[149.795526] [016/142] (861s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_ccs)
[150.396208] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_ccs
[150.400492] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.005s)
[151.132777] [017/142] (860s left) v3d/v3d_submit_cl (bad-perfmon)
[151.278873] Subtest bad-perfmon: SKIP (0.000s)
[151.334487] [018/142] (860s left) kms_lease (lessee_list)
[151.479855] Starting subtest: lessee_list
[151.481326] Starting dynamic subtest: pipe-A-eDP-1
[151.484494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[151.498555] Starting dynamic subtest: pipe-B-eDP-1
[151.500113] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[151.514516] Starting dynamic subtest: pipe-C-eDP-1
[151.516120] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[151.530068] Starting dynamic subtest: pipe-D-eDP-1
[151.531518] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[151.532852] Subtest lessee_list: SUCCESS (0.015s)
[151.596877] [019/142] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[151.752097] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[151.754912] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[151.843863] [020/142] (859s left) gem_exec_schedule (u-semaphore-resolve)
[151.979408] Starting subtest: u-semaphore-resolve
[152.035054] Subtest u-semaphore-resolve: SUCCESS (0.058s)
[152.391801] [021/142] (859s left) vc4/vc4_wait_bo (bad-bo)
[152.535379] Subtest bad-bo: SKIP (0.000s)
[152.592882] [022/142] (858s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[152.736321] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[152.737937] Starting dynamic subtest: pipe-A-eDP-1
[152.857920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.120s)
[153.198142] Starting dynamic subtest: pipe-B-eDP-1
[154.074363] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.889s)
[154.398731] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.662s)
[155.294226] [023/142] (856s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[155.448502] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[155.451261] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[155.546944] [024/142] (856s left) kms_atomic_transition (modeset-transition-fencing)
[155.694100] Starting subtest: modeset-transition-fencing
[155.695431] Starting dynamic subtest: 1x-outputs
[168.864637] Dynamic subtest 1x-outputs: SUCCESS (13.172s)
[169.185285] Subtest modeset-transition-fencing: SUCCESS (13.491s)
[170.095685] [025/142] (841s left) v3d/v3d_mmap (mmap-bad-handle)
[170.247750] Subtest mmap-bad-handle: SKIP (0.000s)
[170.302418] [026/142] (841s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[170.402888] Starting subtest: invalid-signal-one-illegal-handle
[170.404465] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.001s)
[170.478236] [027/142] (841s left) gem_ctx_exec (basic-norecovery)
[170.579654] Starting subtest: basic-norecovery
[171.267818] Subtest basic-norecovery: SUCCESS (0.685s)
[171.376861] [028/142] (840s left) gem_exec_reloc (basic-write-gtt)
[171.491153] Subtest basic-write-gtt: SKIP (0.000s)
[171.558626] [029/142] (840s left) v3d/v3d_wait_bo (unused-bo-0ns)
[171.715363] Subtest unused-bo-0ns: SKIP (0.000s)
[171.772317] [030/142] (840s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[171.915979] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[171.918177] Starting dynamic subtest: pipe-A-default-mode
[173.200737] Dynamic subtest pipe-A-default-mode: SKIP (1.278s)
[173.203662] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.283s)
[173.361793] [031/142] (838s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[173.485703] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[173.547335] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.059s)
[173.629661] [032/142] (838s left) gem_ctx_param (non-root-set)
[173.728975] Starting subtest: non-root-set
[173.756314] Subtest non-root-set: SUCCESS (0.027s)
[173.830899] [033/142] (838s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[173.978908] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[173.981857] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[174.080309] [034/142] (837s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[174.231593] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[174.234519] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[174.339092] [035/142] (837s left) gem_mmap_wc (copy)
[174.444687] Subtest copy: SKIP (0.000s)
[174.485157] [036/142] (837s left) kms_vblank (pipe-b-query-idle)
[174.628448] Starting subtest: pipe-B-query-idle
[177.563055] Subtest pipe-B-query-idle: SUCCESS (2.935s)
[178.495589] [037/142] (833s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[178.599196] Starting subtest: etime-single-wait-all-for-submit-submitted
[178.705698] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[178.779241] [038/142] (833s left) kms_frontbuffer_tracking (psr-suspend)
[178.935560] Starting subtest: psr-suspend
[218.233673] Subtest psr-suspend: SUCCESS (9.220s)
[224.391398] [039/142] (823s left) syncobj_basic (bad-pad-handle-to-fd)
[224.495549] Starting subtest: bad-pad-handle-to-fd
[224.497225] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[224.577945] [040/142] (823s left) gem_ctx_persistence (heartbeat-many)
[224.685341] Starting subtest: heartbeat-many
[224.688280] Subtest heartbeat-many: SKIP (0.000s)
[224.766998] [041/142] (823s left) gem_exercise_blt (fast-copy)
[224.874445] Starting subtest: fast-copy
[224.875930] Starting dynamic subtest: linear-smem-smem
[224.943143] Dynamic subtest linear-smem-smem: SUCCESS (0.067s)
[224.960739] Starting dynamic subtest: xmajor-smem-smem
[224.997057] Dynamic subtest xmajor-smem-smem: SUCCESS (0.052s)
[225.015077] Starting dynamic subtest: tile4-smem-smem
[225.047717] Dynamic subtest tile4-smem-smem: SUCCESS (0.049s)
[225.066369] Starting dynamic subtest: tile64-smem-smem
[225.099207] Dynamic subtest tile64-smem-smem: SUCCESS (0.050s)
[225.101057] Subtest fast-copy: SUCCESS (0.225s)
[225.212297] [042/142] (823s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[225.389426] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[226.528256] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (1.135s)
[226.770112] [043/142] (821s left) vc4/vc4_perfmon (create-single-perfmon)
[226.909301] Subtest create-single-perfmon: SKIP (0.000s)
[226.967473] [044/142] (821s left) gem_partial_pwrite_pread (write-uncached)
[227.074673] Subtest write-uncached: SKIP (0.000s)
[227.146033] [045/142] (821s left) gen7_exec_parse (basic-offset)
[227.252804] Subtest basic-offset: SKIP (0.000s)
[227.299786] [046/142] (821s left) i915_pm_rpm (gem-pread)
[229.698139] Starting subtest: gem-pread
[235.106751] Subtest gem-pread: SUCCESS (5.409s)
[235.216250] [047/142] (813s left) kms_plane_alpha_blend (alpha-basic)
[235.361763] Starting subtest: alpha-basic
[235.880465] Starting dynamic subtest: pipe-A-eDP-1
[237.942704] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.060s)
[238.008307] Starting dynamic subtest: pipe-D-eDP-1
[240.780753] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.786s)
[240.782231] Subtest alpha-basic: SUCCESS (5.417s)
[241.683436] [048/142] (806s left) dmabuf_sync_file (import-multiple-read-write)
[241.799038] Starting subtest: import-multiple-read-write
[241.807947] Subtest import-multiple-read-write: SUCCESS (0.010s)
[241.873250] [049/142] (806s left) kms_psr (psr2_sprite_mmap_gtt)
[242.022146] Starting subtest: psr2_sprite_mmap_gtt
[243.550176] Subtest psr2_sprite_mmap_gtt: SKIP (1.524s)
[243.734076] [050/142] (804s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[243.890359] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[243.893187] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[243.996389] [051/142] (804s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[244.150340] Starting subtest: fbc-rgb565-draw-render
[247.881535] Subtest fbc-rgb565-draw-render: SUCCESS (3.733s)
[248.032509] [052/142] (800s left) sw_sync (timeline_closed_signaled)
[248.135495] Starting subtest: timeline_closed_signaled
[248.137545] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[248.201206] [053/142] (800s left) kms_psr (psr2_dpms)
[248.345679] Starting subtest: psr2_dpms
[251.523259] Subtest psr2_dpms: SUCCESS (3.178s)
[252.426551] [054/142] (796s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[252.898544] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[253.754760] [055/142] (795s left) kms_concurrent (pipe-b)
[253.903810] Starting subtest: pipe-B
[253.905230] Starting dynamic subtest: eDP-1
[255.668305] Dynamic subtest eDP-1: SUCCESS (1.763s)
[255.669910] Subtest pipe-B: SUCCESS (1.767s)
[256.572458] [056/142] (792s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[256.682667] Subtest writes-after-reads-uncached: SKIP (0.000s)
[256.757650] [057/142] (792s left) syncobj_basic (bad-pad-fd-to-handle)
[256.856896] Starting subtest: bad-pad-fd-to-handle
[256.858971] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[256.935150] [058/142] (791s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[257.088648] Starting subtest: fbcpsr-rgb101010-draw-blt
[261.939862] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.852s)
[262.085864] [059/142] (786s left) kms_plane_lowres (tiling-x)
[262.237417] Starting subtest: tiling-x
[262.239017] Starting dynamic subtest: pipe-A-eDP-1
[262.241898] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.571895] Starting dynamic subtest: pipe-B-eDP-1
[262.574655] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.592732] Starting dynamic subtest: pipe-C-eDP-1
[262.596077] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.614025] Starting dynamic subtest: pipe-D-eDP-1
[262.617028] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.620045] Subtest tiling-x: SKIP (0.342s)
[263.449927] [060/142] (785s left) kms_setmode (clone-exclusive-crtc)
[263.553841] Starting subtest: clone-exclusive-crtc
[263.558319] Subtest clone-exclusive-crtc: SKIP (0.001s)
[263.632981] [061/142] (785s left) gem_exec_create (legacy)
[263.753888] Starting subtest: legacy
[263.755648] Starting dynamic subtest: smem
[267.478669] Dynamic subtest smem: SUCCESS (3.724s)
[267.480377] Subtest legacy: SUCCESS (3.727s)
[267.673049] [062/142] (781s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[268.198475] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs_cc
[268.984651] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.784s)
[270.192949] [063/142] (778s left) gem_userptr_blits (nohangcheck)
[270.347670] Starting subtest: nohangcheck
[270.785371] Subtest nohangcheck: SUCCESS (0.437s)
[270.900228] [064/142] (778s left) gem_ctx_engines (execute-allforone)
[271.024228] Starting subtest: execute-allforone
[271.041316] Subtest execute-allforone: SUCCESS (0.017s)
[271.584500] [065/142] (777s left) gem_pxp (hw-rejects-pxp-buffer)
[274.227114] Starting subtest: hw-rejects-pxp-buffer
[274.229228] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[274.330277] [066/142] (774s left) dumb_buffer (create-valid-dumb)
[274.429910] Starting subtest: create-valid-dumb
[274.431330] Subtest create-valid-dumb: SUCCESS (0.000s)
[274.530872] [067/142] (774s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[274.722549] Starting subtest: cursorB-vs-flipA-legacy
[274.729949] Subtest cursorB-vs-flipA-legacy: SKIP (0.006s)
[274.888112] [068/142] (774s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[275.513237] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs_cc
[276.174713] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.663s)
[277.407299] [069/142] (771s left) syncobj_timeline (single-wait-all-available-signaled)
[277.512364] Starting subtest: single-wait-all-available-signaled
[277.514077] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[277.592644] [070/142] (771s left) kms_psr (cursor_mmap_cpu)
[277.738440] Starting subtest: cursor_mmap_cpu
[279.576182] Subtest cursor_mmap_cpu: SUCCESS (1.835s)
[280.473835] [071/142] (768s left) kms_getfb (getfb-reject-ccs)
[280.577230] Starting subtest: getfb-reject-ccs
[280.578741] Subtest getfb-reject-ccs: SUCCESS (0.001s)
[280.679071] [072/142] (768s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[280.854203] Starting subtest: extended-modeset-hang-newfb-with-reset
[280.858461] Starting dynamic subtest: pipe-A
[285.950661] Dynamic subtest pipe-A: SUCCESS (5.092s)
[285.978208] Starting dynamic subtest: pipe-D
[292.793233] Dynamic subtest pipe-D: SUCCESS (6.833s)
[292.795038] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (11.941s)
[293.703495] [073/142] (755s left) gem_pwrite (basic-exhaustion)
[293.806033] Subtest basic-exhaustion: SKIP (0.000s)
[293.868774] [074/142] (755s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[294.031384] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[294.035423] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[294.138941] [075/142] (755s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[294.293237] Starting subtest: fbcpsr-tiling-4
[299.628790] Subtest fbcpsr-tiling-4: SUCCESS (5.334s)
[299.775078] [076/142] (749s left) gem_exec_params (readonly)
[299.886897] Starting subtest: readonly
[299.890604] Subtest readonly: SUCCESS (0.002s)
[299.994391] [077/142] (749s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs)
[300.624909] Starting subtest: pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs
[300.628923] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[301.345375] [078/142] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[301.499637] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[301.502554] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[301.591049] [079/142] (748s left) kms_vrr (negative-basic)
[301.733716] Starting subtest: negative-basic
[301.737861] Starting dynamic subtest: pipe-A-eDP-1
[307.574688] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.836s)
[307.576179] Subtest negative-basic: SUCCESS (5.839s)
[308.473845] [080/142] (741s left) perf_pmu (most-busy-idle-check-all)
[308.583423] Starting subtest: most-busy-idle-check-all
[308.585227] Starting dynamic subtest: rcs0
[309.259179] Dynamic subtest rcs0: FAIL (0.639s)
[309.279878] Starting dynamic subtest: bcs0
[309.891377] Dynamic subtest bcs0: FAIL (0.626s)
[309.911483] Starting dynamic subtest: vcs0
[310.517053] Dynamic subtest vcs0: FAIL (0.625s)
[310.537648] Starting dynamic subtest: vcs1
[311.144887] Dynamic subtest vcs1: FAIL (0.626s)
[311.165439] Starting dynamic subtest: vecs0
[311.771143] Dynamic subtest vecs0: FAIL (0.625s)
[311.791327] Starting dynamic subtest: ccs0
[312.396194] Dynamic subtest ccs0: FAIL (0.624s)
[312.397626] Subtest most-busy-idle-check-all: FAIL (3.776s)
[312.607616] [081/142] (737s left) kms_prop_blob (blob-prop-lifetime)
[312.709332] Starting subtest: blob-prop-lifetime
[312.710836] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[312.797185] [082/142] (736s left) kms_color (ctm-signed)
[312.945339] Starting subtest: ctm-signed
[312.946871] Starting dynamic subtest: pipe-A
[315.302954] Dynamic subtest pipe-A: SUCCESS (2.357s)
[315.324235] Starting dynamic subtest: pipe-B
[318.387047] Dynamic subtest pipe-B: SUCCESS (3.082s)
[318.409254] Starting dynamic subtest: pipe-C
[321.418451] Dynamic subtest pipe-C: SUCCESS (3.030s)
[321.441007] Starting dynamic subtest: pipe-D
[324.399624] Dynamic subtest pipe-D: SUCCESS (2.979s)
[324.401064] Subtest ctm-signed: SUCCESS (11.454s)
[325.299562] [083/142] (724s left) kms_getfb (getfb-handle-protection)
[325.404293] Starting subtest: getfb-handle-protection
[325.428838] Subtest getfb-handle-protection: SUCCESS (0.026s)
[325.543638] [084/142] (724s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[325.709687] Starting subtest: y-tiled-64bpp-rotate-90
[325.712758] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[325.811607] [085/142] (724s left) gem_mmap_gtt (cpuset-big-copy-xy)
[325.916517] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[325.964311] [086/142] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[326.110617] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[326.113475] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[326.205684] [087/142] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[326.360498] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[326.363496] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[326.461764] [088/142] (723s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[326.634059] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[327.983073] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.350s)
[328.140103] [089/142] (721s left) kms_flip (flip-vs-panning)
[328.257001] Starting subtest: flip-vs-panning
[328.263756] Starting dynamic subtest: A-eDP1
[337.219219] Dynamic subtest A-eDP1: SUCCESS (8.955s)
[337.242394] Starting dynamic subtest: B-eDP1
[346.179116] Dynamic subtest B-eDP1: SUCCESS (8.958s)
[346.202752] Starting dynamic subtest: C-eDP1
[355.129733] Dynamic subtest C-eDP1: SUCCESS (8.948s)
[355.150724] Starting dynamic subtest: D-eDP1
[364.089625] Dynamic subtest D-eDP1: SUCCESS (8.958s)
[364.100249] Subtest flip-vs-panning: SUCCESS (35.848s)
[365.443878] [090/142] (684s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_mc_ccs)
[365.909782] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_mc_ccs
[365.913714] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[366.807917] [091/142] (683s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[366.915736] Starting subtest: single-wait-all-for-submit-unsubmitted
[367.022450] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[367.101909] [092/142] (683s left) kms_atomic_transition (plane-all-transition-nonblocking)
[367.247547] Starting subtest: plane-all-transition-nonblocking
[367.249028] Starting dynamic subtest: pipe-A-eDP-1
[369.854820] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.605s)
[370.192023] Starting dynamic subtest: pipe-B-eDP-1
[373.733700] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.561s)
[374.045937] Subtest plane-all-transition-nonblocking: SUCCESS (6.800s)
[374.954049] [093/142] (675s left) kms_big_fb (x-tiled-addfb)
[375.142271] Starting subtest: x-tiled-addfb
[375.144855] Subtest x-tiled-addfb: SUCCESS (0.001s)
[375.243173] [094/142] (674s left) gem_pread (uncached)
[375.345835] Subtest uncached: SKIP (0.000s)
[375.410929] [095/142] (674s left) gem_exec_reloc (basic-cpu-gtt)
[375.518473] Subtest basic-cpu-gtt: SKIP (0.000s)
[375.593726] [096/142] (674s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[375.755070] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[375.758055] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[375.865987] [097/142] (674s left) kms_rotation_crc (sprite-rotation-180)
[376.016895] Starting subtest: sprite-rotation-180
[382.702020] Subtest sprite-rotation-180: SUCCESS (6.687s)
[384.069503] [098/142] (666s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs)
[384.737460] Starting subtest: pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs
[384.741171] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[385.435253] [099/142] (664s left) kms_plane_scaling (invalid-parameters)
[385.581827] Starting subtest: invalid-parameters
[385.583378] Starting dynamic subtest: less-than-1-height-src
[385.611307] Dynamic subtest less-than-1-height-src: SUCCESS (0.030s)
[385.631924] Starting dynamic subtest: less-than-1-width-src
[385.642079] Dynamic subtest less-than-1-width-src: SUCCESS (0.029s)
[385.643597] Subtest invalid-parameters: SUCCESS (0.062s)
[385.751874] [100/142] (664s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_mc_ccs)
[386.318651] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs
[386.320465] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_mc_ccs: SUCCESS (0.002s)
[387.107995] [101/142] (663s left) kms_cursor_crc (cursor-onscreen-64x21)
[387.376391] Starting subtest: cursor-onscreen-64x21
[387.390257] Starting dynamic subtest: pipe-A-eDP-1
[389.961162] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.569s)
[390.033960] Starting dynamic subtest: pipe-D-eDP-1
[393.195836] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.181s)
[393.197640] Subtest cursor-onscreen-64x21: SUCCESS (5.819s)
[394.103857] [102/142] (656s left) kms_sysfs_edid_timing
[394.493468] [103/142] (656s left) syncobj_timeline (multi-wait-all-available-submitted)
[394.588529] Starting subtest: multi-wait-all-available-submitted
[394.589775] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[394.669604] [104/142] (655s left) gem_exec_schedule (preempt-other-chain)
[394.792337] Starting subtest: preempt-other-chain
[394.793871] Starting dynamic subtest: rcs0
[394.933533] Dynamic subtest rcs0: SUCCESS (0.138s)
[394.952937] Starting dynamic subtest: bcs0
[395.031071] Dynamic subtest bcs0: SUCCESS (0.098s)
[395.050206] Starting dynamic subtest: vcs0
[395.117603] Dynamic subtest vcs0: SUCCESS (0.086s)
[395.137959] Starting dynamic subtest: vcs1
[395.195903] Dynamic subtest vcs1: SUCCESS (0.077s)
[395.215621] Starting dynamic subtest: vecs0
[395.267155] Dynamic subtest vecs0: SUCCESS (0.071s)
[395.287266] Starting dynamic subtest: ccs0
[395.339872] Dynamic subtest ccs0: SUCCESS (0.072s)
[395.341550] Subtest preempt-other-chain: SUCCESS (0.546s)
[396.634437] [105/142] (653s left) i915_getparams_basic (basic-eu-total)
[396.737619] Starting subtest: basic-eu-total
[396.741057] Subtest basic-eu-total: SUCCESS (0.000s)
[396.817591] [106/142] (653s left) gem_mmap_gtt (basic-read)
[396.918179] Subtest basic-read: SKIP (0.000s)
[396.967068] [107/142] (653s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[397.069036] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[397.174861] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[397.254441] [108/142] (653s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs)
[397.840735] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs
[397.845165] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[398.619905] [109/142] (652s left) sw_sync (sync_multi_timeline_wait)
[398.718725] Starting subtest: sync_multi_timeline_wait
[398.720310] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[398.787602] [110/142] (652s left) gem_userptr_blits (unsync-unmap-cycles)
[398.899257] Subtest unsync-unmap-cycles: SKIP (0.000s)
[399.049342] [111/142] (651s left) i915_suspend (basic-s2idle-without-i915)
[399.144517] Starting subtest: basic-s2idle-without-i915
[418.862557] Subtest basic-s2idle-without-i915: SUCCESS (4.697s)
[418.956178] [112/142] (646s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[419.156189] Starting subtest: yf-tiled-64bpp-rotate-90
[419.159050] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[419.247479] [113/142] (646s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[419.352366] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[419.354001] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[419.427046] [114/142] (646s left) kms_cursor_crc (cursor-random-256x85)
[419.798480] Starting subtest: cursor-random-256x85
[419.828878] Starting dynamic subtest: pipe-A-eDP-1
[423.912915] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.085s)
[423.986359] Starting dynamic subtest: pipe-D-eDP-1
[428.619251] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.648s)
[428.621076] Subtest cursor-random-256x85: SUCCESS (8.819s)
[429.520957] [115/142] (636s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[429.638278] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[429.642002] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[429.832492] [116/142] (636s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[429.979502] Starting subtest: primary-y-tiled-reflect-x-0
[430.059850] Subtest primary-y-tiled-reflect-x-0: SKIP (0.080s)
[430.179246] [117/142] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[430.332358] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[435.939974] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (5.607s)
[436.086288] [118/142] (630s left) kms_rotation_crc (sprite-rotation-90)
[436.232129] Starting subtest: sprite-rotation-90
[436.235145] Subtest sprite-rotation-90: SKIP (0.003s)
[436.311936] [119/142] (629s left) gem_lmem_swapping (massive)
[436.428072] Subtest massive: SKIP (0.000s)
[436.474088] [120/142] (629s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[436.953958] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[437.788019] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.834s)
[439.038449] [121/142] (627s left) syncobj_wait (wait-all-complex)
[439.142019] Starting subtest: wait-all-complex
[439.363051] Subtest wait-all-complex: SUCCESS (0.217s)
[439.440576] [122/142] (626s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[439.545631] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[439.650124] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[439.727785] [123/142] (626s left) kms_display_modes (extended-mode-basic)
[439.876172] Starting subtest: extended-mode-basic
[439.879805] Subtest extended-mode-basic: SKIP (0.001s)
[439.928477] [124/142] (626s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[440.040352] Starting subtest: y-tiled-ccs-to-y-tiled
[440.043378] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[440.233118] [125/142] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[440.387452] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[440.390358] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[440.489445] [126/142] (625s left) gem_exec_balancer (bonded-chain)
[440.610391] Starting subtest: bonded-chain
[448.327107] Subtest bonded-chain: SUCCESS (7.714s)
[448.555367] [127/142] (617s left) gem_ringfill (basic-all)
[454.537593] Starting subtest: basic-all
[455.717575] Subtest basic-all: SUCCESS (1.181s)
[455.840240] [128/142] (610s left) kms_color (ctm-0-50)
[455.999800] Starting subtest: ctm-0-50
[456.001362] Starting dynamic subtest: pipe-A
[459.921658] Dynamic subtest pipe-A: SUCCESS (3.920s)
[459.943670] Starting dynamic subtest: pipe-B
[464.621089] Dynamic subtest pipe-B: SUCCESS (4.697s)
[464.640589] Starting dynamic subtest: pipe-C
[469.050572] Dynamic subtest pipe-C: SUCCESS (4.427s)
[469.072961] Starting dynamic subtest: pipe-D
[473.490684] Dynamic subtest pipe-D: SUCCESS (4.440s)
[473.492218] Subtest ctm-0-50: SUCCESS (17.491s)
[474.393804] [129/142] (592s left) kms_cursor_crc (cursor-sliding-512x170)
[474.808945] Starting subtest: cursor-sliding-512x170
[474.813636] Subtest cursor-sliding-512x170: SKIP (0.003s)
[474.958904] [130/142] (591s left) gem_ctx_sseu (engines)
[475.067454] Subtest engines: SKIP (0.000s)
[475.115840] [131/142] (591s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[475.302147] Starting subtest: cursorB-vs-flipA-atomic
[475.306630] Subtest cursorB-vs-flipA-atomic: SKIP (0.005s)
[475.466367] [132/142] (591s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[476.008214] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[476.012330] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[476.822148] [133/142] (589s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[477.470279] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs
[477.474214] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[478.182350] [134/142] (588s left) core_auth (getclient-simple)
[478.281608] Starting subtest: getclient-simple
[478.288448] Subtest getclient-simple: SUCCESS (0.005s)
[478.365404] [135/142] (588s left) syncobj_timeline (wait-delayed-signal)
[478.469186] Starting subtest: wait-delayed-signal
[478.574459] Subtest wait-delayed-signal: SUCCESS (0.104s)
[478.655020] [136/142] (588s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[478.800024] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[478.801763] Starting dynamic subtest: pipe-A-eDP-1
[478.910652] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[478.932158] Starting dynamic subtest: pipe-B-eDP-1
[480.228280] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.313s)
[480.249746] Starting dynamic subtest: pipe-C-eDP-1
[481.495105] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.263s)
[481.519892] Starting dynamic subtest: pipe-D-eDP-1
[482.774475] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.275s)
[482.775967] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.977s)
[484.077010] [137/142] (582s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[484.223459] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[486.048494] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (1.823s)
[486.949077] [138/142] (579s left) gem_render_linear_blits (basic)
[487.059338] Starting subtest: basic
[487.112196] Subtest basic: SUCCESS (0.053s)
[487.199443] [139/142] (579s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[487.345585] Starting subtest: plane-primary-toggle-with-vblank-wait
[487.349431] Starting dynamic subtest: pipe-A-eDP-1
[487.543037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.194s)
[487.902697] Starting dynamic subtest: pipe-B-eDP-1
[488.848103] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.968s)
[489.163097] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.815s)
[490.061479] [140/142] (576s left) gem_exec_fence (syncobj-wait)
[490.902714] Starting subtest: syncobj-wait
[492.579843] Subtest syncobj-wait: SUCCESS (1.678s)
[494.601209] [141/142] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[494.765819] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[501.080582] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (6.314s)
[501.227120] [142/142] (565s left) kms_atomic_interruptible (atomic-setmode)
[501.386701] Starting subtest: atomic-setmode
[501.390368] Starting dynamic subtest: eDP-1-pipe-A
[508.393243] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.002s)
[508.394728] Subtest atomic-setmode: SUCCESS (7.007s)
[509.289667] Closing watchdogs
Done.