[48.145995] Initializing watchdogs
[48.146044]   /dev/watchdog0
[48.150766] [001/142] (960s left) kms_panel_fitting (atomic-fastset)
[48.225977] Starting subtest: atomic-fastset
[48.227261] Starting dynamic subtest: pipe-A-eDP-1
[48.378164] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.153s)
[48.386547] Starting dynamic subtest: pipe-B-eDP-1
[49.701587] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.322s)
[49.710046] Starting dynamic subtest: pipe-C-eDP-1
[50.933900] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[50.941572] Starting dynamic subtest: pipe-D-eDP-1
[52.150205] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[52.151358] Subtest atomic-fastset: SUCCESS (3.925s)
[53.445997] [002/142] (955s left) gen7_exec_parse (basic-allowed)
[53.518067] Subtest basic-allowed: SKIP (0.000s)
[53.551297] [003/142] (955s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[53.622216] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[58.844764] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.224s)
[58.964365] [004/142] (949s left) vc4/vc4_mmap (mmap-bo)
[59.028935] Subtest mmap-bo: SKIP (0.000s)
[59.074607] [005/142] (949s left) perf (missing-sample-flags)
[59.225680] Starting subtest: missing-sample-flags
[59.226638] Subtest missing-sample-flags: SUCCESS (0.000s)
[59.245515] [006/142] (949s left) api_intel_bb (object-noreloc-keep-cache-simple)
[59.273491] Starting subtest: object-noreloc-keep-cache-simple
[59.275671] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.002s)
[59.372618] [007/142] (949s left) kms_addfb_basic (bad-pitch-256)
[59.419756] Starting subtest: bad-pitch-256
[59.420994] Subtest bad-pitch-256: SUCCESS (0.000s)
[59.532208] [008/142] (949s left) kms_vblank (pipe-d-ts-continuation-idle-hang)
[59.613727] Starting subtest: pipe-D-ts-continuation-idle-hang
[74.349776] Subtest pipe-D-ts-continuation-idle-hang: SUCCESS (14.739s)
[75.246110] [009/142] (933s left) kms_color (ctm-signed)
[75.297193] Starting subtest: ctm-signed
[75.298525] Starting dynamic subtest: pipe-A
[77.504085] Dynamic subtest pipe-A: SUCCESS (2.206s)
[77.514309] Starting dynamic subtest: pipe-B
[80.415218] Dynamic subtest pipe-B: SUCCESS (2.911s)
[80.424721] Starting dynamic subtest: pipe-C
[83.261666] Dynamic subtest pipe-C: SUCCESS (2.846s)
[83.271045] Starting dynamic subtest: pipe-D
[86.054197] Dynamic subtest pipe-D: SUCCESS (2.793s)
[86.055290] Subtest ctm-signed: SUCCESS (10.757s)
[86.976668] [010/142] (921s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[87.051920] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[91.848785] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.798s)
[91.933800] [011/142] (916s left) gem_spin_batch (resubmit-new-all)
[91.994641] Starting subtest: resubmit-new-all
[91.996102] Starting dynamic subtest: rcs0
[92.004190] Dynamic subtest rcs0: SUCCESS (0.010s)
[92.016570] Starting dynamic subtest: bcs0
[92.017828] Dynamic subtest bcs0: SUCCESS (0.009s)
[92.025483] Starting dynamic subtest: vcs0
[92.026559] Dynamic subtest vcs0: SUCCESS (0.008s)
[92.032029] Starting dynamic subtest: vcs1
[92.033172] Dynamic subtest vcs1: SUCCESS (0.005s)
[92.037832] Starting dynamic subtest: vecs0
[92.039048] Dynamic subtest vecs0: SUCCESS (0.004s)
[92.043180] Starting dynamic subtest: ccs0
[92.048772] Dynamic subtest ccs0: SUCCESS (0.006s)
[92.049907] Subtest resubmit-new-all: SUCCESS (0.045s)
[93.483298] [012/142] (915s left) sw_sync (alloc_merge_fence)
[93.527420] Starting subtest: alloc_merge_fence
[93.528423] Subtest alloc_merge_fence: SUCCESS (0.000s)
[93.562874] [013/142] (915s left) gem_exec_balancer (full-late-pulse)
[93.623063] Starting subtest: full-late-pulse
[98.092552] Subtest full-late-pulse: SUCCESS (4.472s)
[98.339519] [014/142] (910s left) kms_busy (extended-modeset-hang-newfb)
[98.416419] Starting subtest: extended-modeset-hang-newfb
[98.417720] Starting dynamic subtest: pipe-A
[120.422017] Dynamic subtest pipe-A: SUCCESS (22.005s)
[120.436672] Starting dynamic subtest: pipe-D
[143.456783] Dynamic subtest pipe-D: SUCCESS (23.030s)
[143.458060] Subtest extended-modeset-hang-newfb: SUCCESS (45.042s)
[144.389331] [015/142] (864s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[144.443142] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[144.444243] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[144.506334] [016/142] (864s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[144.909316] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[144.912349] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[145.796476] [017/142] (863s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[145.872910] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[150.895205] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (5.022s)
[151.041822] [018/142] (857s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[151.409658] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[151.412021] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[152.324202] [019/142] (856s left) gem_pxp (hw-rejects-pxp-buffer)
[154.902499] Starting subtest: hw-rejects-pxp-buffer
[154.903820] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[154.981028] [020/142] (854s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[155.018661] Starting subtest: multi-wait-available-submitted-signaled
[155.019738] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[155.078862] [021/142] (853s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[155.160616] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[155.161742] Starting dynamic subtest: pipe-A-default-mode
[155.451157] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[155.453335] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.291s)
[156.358887] [022/142] (852s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[156.739758] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[156.743250] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[157.633376] [023/142] (851s left) gem_exec_flush (basic-batch-kernel-default-uc)
[157.700996] Starting subtest: basic-batch-kernel-default-uc
[194.855027] Subtest basic-batch-kernel-default-uc: FAIL (37.126s)
[195.149937] [024/142] (813s left) gem_render_copy_redux (flink)
[195.225831] Starting subtest: flink
[196.124212] Subtest flink: SUCCESS (0.897s)
[196.219085] [025/142] (812s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[196.306035] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[199.922293] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.617s)
[200.038877] [026/142] (809s left) gem_exec_capture (pi)
[200.094479] Starting subtest: pi
[200.095466] Starting dynamic subtest: rcs0
[204.395699] Dynamic subtest rcs0: SUCCESS (4.302s)
[204.411016] Starting dynamic subtest: bcs0
[208.350654] Dynamic subtest bcs0: SUCCESS (3.954s)
[208.363462] Starting dynamic subtest: vcs0
[212.326586] Dynamic subtest vcs0: SUCCESS (3.975s)
[212.341082] Starting dynamic subtest: vcs1
[216.294549] Dynamic subtest vcs1: SUCCESS (3.967s)
[216.299462] Starting dynamic subtest: vecs0
[220.288839] Dynamic subtest vecs0: SUCCESS (3.990s)
[220.294077] Starting dynamic subtest: ccs0
[224.367856] Dynamic subtest ccs0: SUCCESS (4.081s)
[224.369094] Subtest pi: SUCCESS (24.274s)
[224.438466] [027/142] (784s left) kms_atomic (plane-immutable-zpos)
[224.703640] Starting subtest: plane-immutable-zpos
[225.031242] Subtest plane-immutable-zpos: SUCCESS (0.328s)
[226.262827] [028/142] (782s left) kms_plane_lowres (tiling-y)
[226.343093] Starting subtest: tiling-y
[226.345392] Subtest tiling-y: SKIP (0.000s)
[226.406415] [029/142] (782s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs)
[226.476835] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs
[226.479217] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[227.657104] [030/142] (781s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[227.721592] Starting subtest: single-wait-all-for-submit-available-submitted
[227.722813] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[227.784742] [031/142] (781s left) gem_mmap_wc (write-cpu-read-wc)
[227.834443] Subtest write-cpu-read-wc: SKIP (0.000s)
[227.861050] [032/142] (781s left) sysfs_timeslice_duration (duration)
[227.896225] Starting subtest: duration
[227.897407] Starting dynamic subtest: vecs0
[241.444293] Dynamic subtest vecs0: SUCCESS (13.545s)
[241.459074] Starting dynamic subtest: ccs0
[254.569458] Dynamic subtest ccs0: SUCCESS (13.126s)
[254.583243] Starting dynamic subtest: vcs0
[268.451684] Dynamic subtest vcs0: SUCCESS (13.880s)
[268.465343] Starting dynamic subtest: bcs0
[281.569530] Dynamic subtest bcs0: SUCCESS (13.119s)
[281.584975] Starting dynamic subtest: rcs0
[294.689781] Dynamic subtest rcs0: SUCCESS (13.119s)
[294.703253] Starting dynamic subtest: vcs1
[308.451736] Dynamic subtest vcs1: SUCCESS (13.758s)
[308.453463] Subtest duration: SUCCESS (80.553s)
[308.514267] [033/142] (700s left) gem_userptr_blits (forbidden-operations)
[308.550922] Starting subtest: forbidden-operations
[308.553137] Subtest forbidden-operations: SKIP (0.000s)
[308.666243] [034/142] (700s left) kms_rotation_crc (sprite-rotation-180)
[308.709593] Starting subtest: sprite-rotation-180
[314.746578] Subtest sprite-rotation-180: SUCCESS (6.038s)
[316.040599] [035/142] (693s left) gem_exec_reloc (basic-gtt-active)
[316.094889] Subtest basic-gtt-active: SKIP (0.000s)
[316.159836] [036/142] (693s left) kms_psr2_sf (cursor-plane-update-sf)
[321.370501] Starting subtest: cursor-plane-update-sf
[321.371754] Starting dynamic subtest: pipe-A-eDP-1
[322.779172] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.405s)
[322.793205] Starting dynamic subtest: pipe-B-eDP-1
[324.142059] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.359s)
[324.143509] Subtest cursor-plane-update-sf: SUCCESS (2.771s)
[325.062537] [037/142] (684s left) kms_cursor_crc (cursor-random-max-size)
[325.282802] Starting subtest: cursor-random-max-size
[325.285849] Subtest cursor-random-max-size: SKIP (0.000s)
[325.385878] [038/142] (684s left) gem_exec_fence (invalid-timeline-fence-array)
[325.982988] Starting subtest: invalid-timeline-fence-array
[325.986510] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[327.555970] [039/142] (681s left) gem_mmap_gtt (cpuset-big-copy-odd)
[327.607843] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[327.634166] [040/142] (681s left) kms_lease (lease-again)
[327.708020] Starting subtest: lease-again
[327.709183] Starting dynamic subtest: pipe-A-eDP-1
[327.712645] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[327.727427] Starting dynamic subtest: pipe-B-eDP-1
[327.728430] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[327.734812] Starting dynamic subtest: pipe-C-eDP-1
[327.735844] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[327.740864] Starting dynamic subtest: pipe-D-eDP-1
[327.741854] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[327.742849] Subtest lease-again: SUCCESS (0.016s)
[327.827071] [041/142] (681s left) gem_userptr_blits (dmabuf-unsync)
[327.879084] Subtest dmabuf-unsync: SKIP (0.000s)
[327.991480] [042/142] (681s left) prime_mmap_coherency (read)
[328.038160] Starting subtest: read
[333.413454] Subtest read: SUCCESS (5.374s)
[333.509809] [043/142] (676s left) gem_exec_reloc (basic-wc-cpu-active)
[333.545629] Subtest basic-wc-cpu-active: SKIP (0.000s)
[333.598797] [044/142] (675s left) kms_big_fb (linear-32bpp-rotate-270)
[333.657867] Starting subtest: linear-32bpp-rotate-270
[333.678472] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[333.771476] [045/142] (675s left) kms_flip (2x-wf_vblank-ts-check)
[333.827189] Starting subtest: 2x-wf_vblank-ts-check
[333.840604] Subtest 2x-wf_vblank-ts-check: SKIP (0.013s)
[333.904267] [046/142] (675s left) syncobj_basic (bad-destroy)
[333.957279] Starting subtest: bad-destroy
[333.958411] Subtest bad-destroy: SUCCESS (0.000s)
[334.007815] [047/142] (675s left) kms_rotation_crc (exhaust-fences)
[334.054740] Starting subtest: exhaust-fences
[334.056940] Subtest exhaust-fences: SKIP (0.000s)
[334.100267] [048/142] (675s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-a)
[334.164382] Starting subtest: universal-plane-pageflip-windowed-pipe-A
[334.733465] Subtest universal-plane-pageflip-windowed-pipe-A: SUCCESS (0.570s)
[335.624177] [049/142] (674s left) gem_exec_flush (basic-wb-prw-default)
[335.687410] Starting subtest: basic-wb-prw-default
[341.137879] Subtest basic-wb-prw-default: SUCCESS (5.451s)
[341.318235] [050/142] (668s left) kms_vblank (pipe-b-query-forked-hang)
[341.382643] Starting subtest: pipe-B-query-forked-hang
[356.291792] Subtest pipe-B-query-forked-hang: SUCCESS (14.908s)
[357.184930] [051/142] (652s left) syncobj_basic (bad-flags-handle-to-fd)
[357.212045] Starting subtest: bad-flags-handle-to-fd
[357.213117] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[357.261780] [052/142] (652s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[357.323187] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[357.325258] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[357.412850] [053/142] (652s left) kms_cursor_crc (cursor-onscreen-128x42)
[357.556543] Starting subtest: cursor-onscreen-128x42
[357.563097] Starting dynamic subtest: pipe-A-eDP-1
[359.697383] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.134s)
[359.724735] Starting dynamic subtest: pipe-D-eDP-1
[362.540750] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.820s)
[362.541971] Subtest cursor-onscreen-128x42: SUCCESS (4.983s)
[363.434369] [054/142] (646s left) kms_selftest (drm_dp_mst)
[363.478483] Starting subtest: drm_dp_mst
[363.496997] Starting dynamic subtest: drm_dp_mst_helper-drm_test_dp_mst_calc_pbn_mode
[363.498221] Dynamic subtest drm_dp_mst_helper-drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.000s)
[363.516930] Starting dynamic subtest: drm_dp_mst_helper-drm_test_dp_mst_sideband_msg_req_decode
[363.518026] Dynamic subtest drm_dp_mst_helper-drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.000s)
[363.519062] Subtest drm_dp_mst: SUCCESS (0.028s)
[363.631474] [055/142] (646s left) kms_flip (flip-vs-rmfb-interruptible)
[363.679523] Starting subtest: flip-vs-rmfb-interruptible
[363.682466] Starting dynamic subtest: A-eDP1
[372.402944] Dynamic subtest A-eDP1: SUCCESS (8.722s)
[372.419092] Starting dynamic subtest: B-eDP1
[381.171122] Dynamic subtest B-eDP1: SUCCESS (8.766s)
[381.184201] Starting dynamic subtest: C-eDP1
[389.865434] Dynamic subtest C-eDP1: SUCCESS (8.693s)
[389.881341] Starting dynamic subtest: D-eDP1
[398.573408] Dynamic subtest D-eDP1: SUCCESS (8.703s)
[398.578134] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.900s)
[399.818397] [056/142] (609s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[399.882084] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[399.884101] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[399.969628] [057/142] (609s left) kms_psr (sprite_mmap_cpu)
[400.033226] Starting subtest: sprite_mmap_cpu
[401.848703] Subtest sprite_mmap_cpu: SUCCESS (1.814s)
[402.757801] [058/142] (607s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs)
[403.158566] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs
[403.964769] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs: SUCCESS (0.807s)
[405.180312] [059/142] (604s left) perf_pmu (pmu-read)
[405.231625] Starting subtest: pmu-read
[405.232734] Subtest pmu-read: SUCCESS (0.002s)
[405.276091] [060/142] (604s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[405.349292] Starting subtest: cursorA-vs-flipA-varying-size
[416.489613] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.140s)
[417.355833] [061/142] (592s left) syncobj_wait (wait-any-complex)
[417.421975] Starting subtest: wait-any-complex
[417.483409] Subtest wait-any-complex: SUCCESS (0.062s)
[417.551243] [062/142] (592s left) i915_suspend (sysfs-reader)
[417.603267] Starting subtest: sysfs-reader
[435.731472] Subtest sysfs-reader: SUCCESS (3.131s)
[435.764413] [063/142] (589s left) gem_exec_reloc (basic-write-wc)
[435.809480] Subtest basic-write-wc: SKIP (0.000s)
[435.882846] [064/142] (589s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[436.250809] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[436.274278] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SUCCESS (0.024s)
[437.104271] [065/142] (587s left) gem_eio (in-flight-10ms)
[437.330560] Starting subtest: in-flight-10ms
[454.776297] Subtest in-flight-10ms: SUCCESS (17.446s)
[456.505114] [066/142] (568s left) gem_softpin (reverse)
[456.544680] Starting subtest: reverse
[456.548800] Subtest reverse: SUCCESS (0.004s)
[456.642634] [067/142] (568s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[456.707202] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[456.709115] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[456.796902] [068/142] (568s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[456.898424] Starting subtest: cursor-vs-flip-varying-size
[485.766452] Subtest cursor-vs-flip-varying-size: SUCCESS (28.869s)
[486.687822] [069/142] (538s left) gem_exec_schedule (noreorder)
[486.852370] Starting subtest: noreorder
[486.853909] Starting dynamic subtest: rcs0
[501.532748] Dynamic subtest rcs0: FAIL (14.646s)
[501.541963] Starting dynamic subtest: vcs0
[502.470073] Dynamic subtest vcs0: SUCCESS (0.970s)
[502.488189] Starting dynamic subtest: vcs1
[504.480271] Dynamic subtest vcs1: SUCCESS (2.008s)
[504.498134] Starting dynamic subtest: vecs0
[506.431257] Dynamic subtest vecs0: SUCCESS (1.949s)
[506.449100] Starting dynamic subtest: ccs0
[521.565457] Dynamic subtest ccs0: FAIL (15.104s)
[521.566566] Subtest noreorder: FAIL (34.685s)
[521.972697] [070/142] (503s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[522.035630] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[522.037906] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[522.218956] [071/142] (502s left) gen9_exec_parse (unaligned-access)
[522.259438] Subtest unaligned-access: SKIP (0.000s)
[522.282193] [072/142] (502s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[522.343669] Starting subtest: y-tiled-64bpp-rotate-180
[522.345678] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[522.430441] [073/142] (502s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[522.494853] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[522.497238] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[522.579069] [074/142] (502s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[522.648588] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[523.350864] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.703s)
[523.496510] [075/142] (501s left) gem_partial_pwrite_pread (write-snoop)
[523.548282] Subtest write-snoop: SKIP (0.000s)
[523.601138] [076/142] (501s left) vc4/vc4_tiling (get-bad-modifier)
[523.693730] Subtest get-bad-modifier: SKIP (0.000s)
[523.743346] [077/142] (501s left) kms_vblank (pipe-c-wait-forked)
[523.787760] Starting subtest: pipe-C-wait-forked
[526.761332] Subtest pipe-C-wait-forked: SUCCESS (2.973s)
[527.702962] [078/142] (497s left) kms_cursor_edge_walk (64x64-left-edge)
[527.760291] Starting subtest: 64x64-left-edge
[527.761479] Starting dynamic subtest: pipe-A-eDP-1
[531.345193] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.585s)
[531.360063] Starting dynamic subtest: pipe-D-eDP-1
[534.588198] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.239s)
[534.589355] Subtest 64x64-left-edge: SUCCESS (6.829s)
[535.520470] [079/142] (489s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[535.599881] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[535.601860] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[535.685582] [080/142] (489s left) kms_psr2_su (frontbuffer-xrgb8888)
[535.744202] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[535.786868] [081/142] (489s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[535.850193] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[540.485283] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.634s)
[540.618509] [082/142] (484s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[540.698705] Starting subtest: x-tiled-64bpp-rotate-0
[542.271447] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.572s)
[542.513413] [083/142] (482s left) i915_pm_rpm (modeset-non-lpsp-stress-no-wait)
[544.617826] Starting subtest: modeset-non-lpsp-stress-no-wait
[544.872686] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.253s)
[545.194683] [084/142] (480s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[545.539148] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[546.418384] [085/142] (479s left) gem_exec_schedule (preempt-hang)
[546.601144] Starting subtest: preempt-hang
[546.602582] Starting dynamic subtest: rcs0
[546.844650] Dynamic subtest rcs0: SUCCESS (0.243s)
[546.860488] Starting dynamic subtest: bcs0
[547.091130] Dynamic subtest bcs0: SUCCESS (0.245s)
[547.106719] Starting dynamic subtest: vcs0
[550.552303] Dynamic subtest vcs0: SUCCESS (3.461s)
[550.568033] Starting dynamic subtest: vcs1
[550.769753] Dynamic subtest vcs1: SUCCESS (0.216s)
[550.775635] Starting dynamic subtest: vecs0
[550.989514] Dynamic subtest vecs0: SUCCESS (0.218s)
[551.003931] Starting dynamic subtest: ccs0
[551.230742] Dynamic subtest ccs0: SUCCESS (0.241s)
[551.231956] Subtest preempt-hang: SUCCESS (4.632s)
[552.555891] [086/142] (472s left) kms_chamelium_edid (hdmi-mode-timings)
[552.914837] Subtest hdmi-mode-timings: SKIP (0.000s)
[553.776667] [087/142] (471s left) kms_setmode (invalid-clone-single-crtc-stealing)
[553.821726] Starting subtest: invalid-clone-single-crtc-stealing
[553.826429] Subtest invalid-clone-single-crtc-stealing: SKIP (0.001s)
[553.886305] [088/142] (471s left) perf (invalid-oa-exponent)
[553.996742] Starting subtest: invalid-oa-exponent
[554.007721] Subtest invalid-oa-exponent: SUCCESS (0.011s)
[554.031980] [089/142] (471s left) kms_draw_crc (draw-method-mmap-wc)
[554.078390] Starting subtest: draw-method-mmap-wc
[554.079599] Starting dynamic subtest: xrgb8888-untiled
[554.331130] Dynamic subtest xrgb8888-untiled: SUCCESS (0.253s)
[554.348016] Starting dynamic subtest: rgb565-untiled
[554.586539] Dynamic subtest rgb565-untiled: SUCCESS (0.254s)
[554.598846] Starting dynamic subtest: xrgb2101010-untiled
[554.797719] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[554.815313] Starting dynamic subtest: xrgb8888-xtiled
[554.931132] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[554.947239] Starting dynamic subtest: rgb565-xtiled
[555.064509] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[555.081337] Starting dynamic subtest: xrgb2101010-xtiled
[555.164527] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[555.174347] Starting dynamic subtest: xrgb8888-4tiled
[555.289205] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[555.297289] Starting dynamic subtest: rgb565-4tiled
[555.442222] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s)
[555.452810] Starting dynamic subtest: xrgb2101010-4tiled
[555.564560] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[555.565913] Subtest draw-method-mmap-wc: SUCCESS (1.487s)
[555.662784] [090/142] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[555.739947] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[555.741769] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[555.830668] [091/142] (469s left) debugfs_test (read_all_entries_display_on)
[555.894842] Starting subtest: read_all_entries_display_on
[556.242608] Subtest read_all_entries_display_on: SUCCESS (0.348s)
[556.346746] [092/142] (469s left) gem_workarounds (suspend-resume-context)
[556.415605] Starting subtest: suspend-resume-context
[575.163489] Subtest suspend-resume-context: SUCCESS (3.579s)
[581.297318] [093/142] (465s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[581.672480] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[581.675722] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[582.560498] [094/142] (464s left) kms_pipe_crc_basic (nonblocking-crc)
[582.631096] Starting subtest: nonblocking-crc
[582.632255] Starting dynamic subtest: pipe-A-eDP-1
[583.419259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[583.437162] Starting dynamic subtest: pipe-B-eDP-1
[585.016484] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.591s)
[585.031712] Starting dynamic subtest: pipe-C-eDP-1
[586.504867] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.487s)
[586.524368] Starting dynamic subtest: pipe-D-eDP-1
[587.977848] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.469s)
[587.979071] Subtest nonblocking-crc: SUCCESS (5.346s)
[588.897304] [095/142] (457s left) kms_vblank (pipe-b-query-forked)
[588.958187] Starting subtest: pipe-B-query-forked
[591.914526] Subtest pipe-B-query-forked: SUCCESS (2.958s)
[592.849501] [096/142] (454s left) prime_vgem (fence-read-hang)
[592.936075] Subtest fence-read-hang: SKIP (0.000s)
[593.018416] [097/142] (453s left) kms_frontbuffer_tracking (fbc-tiling-y)
[593.081778] Starting subtest: fbc-tiling-y
[593.083863] Subtest fbc-tiling-y: SKIP (0.000s)
[593.163867] [098/142] (453s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[593.229360] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[593.231527] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[593.316312] [099/142] (453s left) gem_lmem_swapping (heavy-verify-random-ccs)
[593.372245] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[593.411601] [100/142] (453s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[593.484955] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[593.535200] [101/142] (453s left) gem_pxp (create-regular-buffer)
[596.124967] Subtest create-regular-buffer: SKIP (0.000s)
[596.184902] [102/142] (450s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[596.250042] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[596.251059] Starting dynamic subtest: pipe-A-eDP-1
[596.260473] Dynamic subtest pipe-A-eDP-1: SKIP (0.010s)
[596.273316] Starting dynamic subtest: pipe-B-eDP-1
[596.281196] Dynamic subtest pipe-B-eDP-1: SKIP (0.019s)
[596.291487] Starting dynamic subtest: pipe-C-eDP-1
[596.298724] Dynamic subtest pipe-C-eDP-1: SKIP (0.018s)
[596.304685] Starting dynamic subtest: pipe-D-eDP-1
[596.319153] Dynamic subtest pipe-D-eDP-1: SKIP (0.020s)
[596.320812] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.071s)
[596.410879] [103/142] (450s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[596.456805] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[596.458811] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[596.534286] [104/142] (450s left) gem_exec_whisper (basic-fds-forked-all)
[596.578179] Starting subtest: basic-fds-forked-all
[628.599821] Subtest basic-fds-forked-all: SUCCESS (32.020s)
[628.783902] [105/142] (418s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[628.833906] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[628.941836] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[629.016587] [106/142] (418s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[629.441531] Starting subtest: pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[629.442835] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SUCCESS (0.000s)
[630.271517] [107/142] (416s left) perf (invalid-open-flags)
[630.360114] Starting subtest: invalid-open-flags
[630.361112] Subtest invalid-open-flags: SUCCESS (0.000s)
[630.384870] [108/142] (416s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[630.439199] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[630.441191] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[630.524611] [109/142] (416s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[630.931825] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[630.934692] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[631.842033] [110/142] (415s left) gem_exec_suspend (basic-s0)
[631.895192] Starting subtest: basic-S0
[631.896685] Starting dynamic subtest: smem
[652.679247] Dynamic subtest smem: SUCCESS (6.686s)
[652.680692] Subtest basic-S0: SUCCESS (6.687s)
[652.859687] [111/142] (408s left) gem_bad_reloc (negative-reloc)
[652.900139] Subtest negative-reloc: SKIP (0.000s)
[652.945651] [112/142] (408s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[653.011573] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[653.013569] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[653.105714] [113/142] (408s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[653.509033] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[654.537559] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.029s)
[655.727799] [114/142] (405s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[655.788561] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[655.789996] Starting dynamic subtest: pipe-A-eDP-1
[660.350508] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.562s)
[660.364708] Starting dynamic subtest: pipe-B-eDP-1
[665.882456] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.528s)
[665.897584] Starting dynamic subtest: pipe-C-eDP-1
[667.217317] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.332s)
[667.231907] Starting dynamic subtest: pipe-D-eDP-1
[668.572532] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[668.573709] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (12.785s)
[669.865796] [115/142] (391s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[670.230987] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[670.233920] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[671.144972] [116/142] (390s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[671.217839] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[671.218970] Starting dynamic subtest: pipe-A-default-mode
[674.173768] Dynamic subtest pipe-A-default-mode: SUCCESS (2.953s)
[674.174999] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.956s)
[675.123436] [117/142] (386s left) perf (gen12-oa-tlb-invalidate)
[675.239322] Starting subtest: gen12-oa-tlb-invalidate
[675.240503] Starting dynamic subtest: 0-rcs0
[685.285039] Dynamic subtest 0-rcs0: SUCCESS (10.042s)
[685.297674] Starting dynamic subtest: 1-vcs0
[695.337629] Dynamic subtest 1-vcs0: SUCCESS (10.052s)
[695.339259] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.097s)
[695.377868] [118/142] (366s left) syncobj_basic (test-valid-cycle)
[695.409475] Starting subtest: test-valid-cycle
[695.410532] Subtest test-valid-cycle: SUCCESS (0.000s)
[695.465878] [119/142] (366s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[695.833022] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[695.836132] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[696.752628] [120/142] (364s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[696.842920] Starting subtest: 4-tiled-8bpp-rotate-180
[697.924064] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.081s)
[698.035821] [121/142] (363s left) gem_ctx_persistence (legacy-engines-mixed)
[698.089281] Starting subtest: legacy-engines-mixed
[698.091372] Starting dynamic subtest: render
[698.136953] Dynamic subtest render: SUCCESS (0.046s)
[698.160544] Starting dynamic subtest: bsd1
[698.174958] Dynamic subtest bsd1: SUCCESS (0.036s)
[698.192146] Starting dynamic subtest: bsd2
[698.210864] Dynamic subtest bsd2: SUCCESS (0.034s)
[698.226390] Starting dynamic subtest: blt
[698.255965] Dynamic subtest blt: SUCCESS (0.043s)
[698.272746] Starting dynamic subtest: vebox
[698.299033] Dynamic subtest vebox: SUCCESS (0.041s)
[698.300865] Subtest legacy-engines-mixed: SUCCESS (0.209s)
[698.374985] [122/142] (363s left) gem_linear_blits (normal)
[698.620958] Starting subtest: normal
[705.088897] Subtest normal: SUCCESS (6.466s)
[705.211372] [123/142] (356s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[705.342737] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[705.344820] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[705.438533] [124/142] (356s left) i915_pm_rpm (cursor)
[707.060004] Starting subtest: cursor
[742.852827] Subtest cursor: SUCCESS (35.793s)
[743.693971] [125/142] (318s left) gem_exec_fence (syncobj-repeat)
[744.140978] Starting subtest: syncobj-repeat
[744.254886] Subtest syncobj-repeat: SUCCESS (0.112s)
[745.760208] [126/142] (315s left) gem_ctx_exec (basic-norecovery)
[745.799266] Starting subtest: basic-norecovery
[746.168206] Subtest basic-norecovery: SUCCESS (0.367s)
[746.271622] [127/142] (315s left) v3d/v3d_submit_cl (bad-bo)
[746.381586] Subtest bad-bo: SKIP (0.000s)
[746.421386] [128/142] (315s left) dmabuf_sync_file (import-multiple-read-write)
[746.456429] Starting subtest: import-multiple-read-write
[746.462318] Subtest import-multiple-read-write: SUCCESS (0.006s)
[746.511600] [129/142] (315s left) gem_ctx_engines (invalid-engines)
[746.567779] Starting subtest: invalid-engines
[746.574638] Subtest invalid-engines: SUCCESS (0.007s)
[746.787137] [130/142] (315s left) kms_ccs (pipe-d-bad-pixel-format-yf_tiled_ccs)
[747.183724] Starting subtest: pipe-D-bad-pixel-format-yf_tiled_ccs
[747.186841] Subtest pipe-D-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[748.081979] [131/142] (313s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[748.132325] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[748.238714] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[748.307224] [132/142] (313s left) i915_pm_rps (thresholds-idle-park)
[748.363894] Starting subtest: thresholds-idle-park
[748.365070] Starting dynamic subtest: gt0
[748.367274] Dynamic subtest gt0: SKIP (0.001s)
[748.385485] Starting dynamic subtest: gt1
[748.387592] Dynamic subtest gt1: SKIP (0.000s)
[748.389651] Subtest thresholds-idle-park: SKIP (0.003s)
[748.416837] [133/142] (313s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[748.521728] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[759.712558] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.191s)
[760.616860] [134/142] (301s left) vgem_basic (unload)
[760.666637] Starting subtest: unload
[789.644633] Subtest unload: SUCCESS (28.972s)
[789.744047] [135/142] (272s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[790.122366] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[790.124191] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.000s)
[790.986001] [136/142] (270s left) gem_ctx_shared (single-timeline)
[791.049432] Starting subtest: single-timeline
[791.060507] Subtest single-timeline: SUCCESS (0.007s)
[791.280740] [137/142] (270s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[791.370876] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[791.373108] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[791.459684] [138/142] (270s left) gem_madvise (dontneed-before-exec)
[791.511108] Starting subtest: dontneed-before-exec
[791.517163] Subtest dontneed-before-exec: SKIP (0.003s)
[791.574462] [139/142] (270s left) v3d/v3d_mmap (mmap-bad-handle)
[791.654359] Subtest mmap-bad-handle: SKIP (0.000s)
[791.705655] [140/142] (270s left) kms_setmode (basic-clone-single-crtc)
[791.748629] Starting subtest: basic-clone-single-crtc
[791.751251] Subtest basic-clone-single-crtc: SKIP (0.001s)
[791.803750] [141/142] (270s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[791.888250] Starting subtest: cursorB-vs-flipB-varying-size
[791.890511] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[791.994130] [142/142] (270s left) kms_chamelium_color (ctm-limited-range)
[792.051905] Subtest ctm-limited-range: SKIP (0.000s)
[792.092377] Closing watchdogs
Done.