[51.160255] Initializing watchdogs
[51.160718]   /dev/watchdog0
[51.191839] [001/142] (960s left) fbdev (nullptr)
[51.614990] Starting subtest: nullptr
[51.618533] Subtest nullptr: SUCCESS (0.000s)
[51.779942] [002/142] (959s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[52.195089] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[52.200442] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[52.485613] [003/142] (959s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[53.044415] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[53.051357] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[53.200450] [004/142] (958s left) v3d/v3d_perfmon (create-two-perfmon)
[53.659474] Subtest create-two-perfmon: SKIP (0.000s)
[53.756088] [005/142] (958s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[54.133866] Starting subtest: multi-wait-all-for-submit-available-signaled
[54.137516] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.003s)
[54.257573] [006/142] (957s left) gem_request_retire (retire-vma-not-inactive)
[54.663973] Starting subtest: retire-vma-not-inactive
[54.763818] Subtest retire-vma-not-inactive: SUCCESS (0.100s)
[56.617143] [007/142] (955s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[57.094999] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[57.101800] Starting dynamic subtest: pipe-A-default-mode
[57.516475] Dynamic subtest pipe-A-default-mode: SKIP (0.409s)
[57.523575] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.418s)
[58.440816] [008/142] (953s left) gem_mmap (bad-offset)
[58.807498] Subtest bad-offset: SKIP (0.000s)
[58.906407] [009/142] (953s left) gem_exec_schedule (wide)
[59.485550] Starting subtest: wide
[59.488874] Starting dynamic subtest: rcs0
[91.662512] Dynamic subtest rcs0: SUCCESS (32.175s)
[91.697595] Starting dynamic subtest: bcs0
[123.882944] Dynamic subtest bcs0: SUCCESS (32.218s)
[123.908934] Starting dynamic subtest: vcs0
[151.070281] Dynamic subtest vcs0: SUCCESS (27.190s)
[151.096163] Starting dynamic subtest: vcs1
[182.613356] Dynamic subtest vcs1: SUCCESS (31.537s)
[182.645324] Starting dynamic subtest: vecs0
[210.710084] Dynamic subtest vecs0: SUCCESS (28.101s)
[210.725242] Starting dynamic subtest: ccs0
[242.433903] Dynamic subtest ccs0: SUCCESS (31.721s)
[242.437145] Subtest wide: SUCCESS (182.947s)
[245.581127] [010/142] (766s left) kms_vblank (pipe-d-query-forked-hang)
[246.075668] Starting subtest: pipe-D-query-forked-hang
[262.825134] Subtest pipe-D-query-forked-hang: SUCCESS (16.752s)
[263.764526] [011/142] (748s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[264.286543] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[274.568546] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (10.288s)
[274.845759] [012/142] (737s left) sysfs_timeslice_duration (timeout)
[275.249118] Starting subtest: timeout
[275.253214] Starting dynamic subtest: vecs0
[284.468425] Dynamic subtest vecs0: SUCCESS (9.216s)
[284.504879] Starting dynamic subtest: ccs0
[287.088286] Dynamic subtest ccs0: SUCCESS (2.623s)
[287.123967] Starting dynamic subtest: vcs0
[296.444310] Dynamic subtest vcs0: SUCCESS (9.351s)
[296.478429] Starting dynamic subtest: bcs0
[298.984597] Dynamic subtest bcs0: SUCCESS (2.542s)
[299.016795] Starting dynamic subtest: rcs0
[301.752352] Dynamic subtest rcs0: SUCCESS (2.767s)
[301.787771] Starting dynamic subtest: vcs1
[311.538867] Dynamic subtest vcs1: SUCCESS (9.783s)
[311.543215] Subtest timeout: SUCCESS (36.292s)
[311.699924] [013/142] (700s left) kms_cursor_edge_walk (256x256-right-edge)
[312.202163] Starting subtest: 256x256-right-edge
[312.205781] Starting dynamic subtest: pipe-A-eDP-1
[317.275589] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.068s)
[317.314317] Starting dynamic subtest: pipe-D-eDP-1
[321.571290] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.287s)
[321.574889] Subtest 256x256-right-edge: SUCCESS (9.371s)
[322.510897] [014/142] (690s left) kms_flip (absolute-wf_vblank-interruptible)
[322.937325] Starting subtest: absolute-wf_vblank-interruptible
[322.968714] Starting dynamic subtest: A-eDP1
[334.433355] Dynamic subtest A-eDP1: SUCCESS (11.465s)
[334.463792] Starting dynamic subtest: B-eDP1
[345.388802] Dynamic subtest B-eDP1: SUCCESS (10.953s)
[345.421938] Starting dynamic subtest: C-eDP1
[356.745736] Dynamic subtest C-eDP1: SUCCESS (11.353s)
[356.781643] Starting dynamic subtest: D-eDP1
[367.781388] Dynamic subtest D-eDP1: SUCCESS (11.034s)
[367.807901] Subtest absolute-wf_vblank-interruptible: SUCCESS (44.871s)
[369.300680] [015/142] (643s left) kms_vblank (pipe-c-query-idle)
[369.772354] Starting subtest: pipe-C-query-idle
[373.298834] Subtest pipe-C-query-idle: SUCCESS (3.529s)
[374.241457] [016/142] (638s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_ccs)
[375.756301] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_ccs
[375.762839] Subtest pipe-C-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[376.613179] [017/142] (636s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[377.151195] Starting subtest: 4-tiled-8bpp-rotate-270
[377.217356] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.059s)
[377.401815] [018/142] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[377.914536] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[377.921748] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[378.082687] [019/142] (634s left) i915_pm_rps (basic-api)
[378.474170] Starting subtest: basic-api
[378.481387] Subtest basic-api: SKIP (0.003s)
[378.620466] [020/142] (634s left) kms_fbcon_fbt (fbc-suspend)
[379.028694] Starting subtest: fbc-suspend
[428.908056] Subtest fbc-suspend: SUCCESS (49.881s)
[429.097779] [021/142] (584s left) gem_spin_batch (engines)
[429.519823] Starting subtest: engines
[429.523398] Starting dynamic subtest: rcs0
[432.758468] Dynamic subtest rcs0: SUCCESS (3.237s)
[432.797067] Starting dynamic subtest: bcs0
[435.992101] Dynamic subtest bcs0: SUCCESS (3.230s)
[436.030164] Starting dynamic subtest: vcs0
[439.321615] Dynamic subtest vcs0: SUCCESS (3.328s)
[439.359820] Starting dynamic subtest: vcs1
[442.553100] Dynamic subtest vcs1: SUCCESS (3.228s)
[442.592731] Starting dynamic subtest: vecs0
[445.782519] Dynamic subtest vecs0: SUCCESS (3.228s)
[445.821631] Starting dynamic subtest: ccs0
[449.014913] Dynamic subtest ccs0: SUCCESS (3.230s)
[449.018237] Subtest engines: SUCCESS (19.495s)
[449.351545] [022/142] (563s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[449.877170] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[458.324067] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (8.452s)
[458.589075] [023/142] (554s left) perf (gen8-unprivileged-single-ctx-counters)
[459.462297] Starting subtest: gen8-unprivileged-single-ctx-counters
[459.468538] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[459.562046] [024/142] (553s left) api_intel_bb (full-batch)
[459.938665] Starting subtest: full-batch
[459.952630] Subtest full-batch: SUCCESS (0.017s)
[460.131620] [025/142] (553s left) gem_tiling_max_stride
[460.612216] [026/142] (552s left) gem_exec_balancer (full-late-pulse)
[461.029784] Starting subtest: full-late-pulse
[471.476234] Subtest full-late-pulse: SUCCESS (10.446s)
[472.516404] [027/142] (541s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[472.916466] Starting subtest: saturated-hostile-nopreempt
[472.920387] Starting dynamic subtest: rcs0
[472.953216] Dynamic subtest rcs0: SKIP (0.032s)
[472.995812] Starting dynamic subtest: bcs0
[473.002798] Dynamic subtest bcs0: SKIP (0.037s)
[473.045585] Starting dynamic subtest: vcs0
[473.053347] Dynamic subtest vcs0: SKIP (0.015s)
[473.096849] Starting dynamic subtest: vcs1
[473.103180] Dynamic subtest vcs1: SKIP (0.014s)
[473.146861] Starting dynamic subtest: vecs0
[473.154899] Dynamic subtest vecs0: SKIP (0.018s)
[473.197433] Starting dynamic subtest: ccs0
[473.204243] Dynamic subtest ccs0: SKIP (0.025s)
[473.210858] Subtest saturated-hostile-nopreempt: SKIP (0.158s)
[473.275352] [028/142] (540s left) gem_lmem_swapping (parallel-multi)
[473.675886] Subtest parallel-multi: SKIP (0.000s)
[473.804546] [029/142] (540s left) i915_hangman (engine-engine-error)
[474.243610] Starting subtest: engine-engine-error
[474.247196] Starting dynamic subtest: rcs0
[475.481673] Dynamic subtest rcs0: SUCCESS (1.235s)
[475.526242] Starting dynamic subtest: bcs0
[477.468285] Dynamic subtest bcs0: SUCCESS (1.980s)
[477.509359] Starting dynamic subtest: vcs0
[479.514181] Dynamic subtest vcs0: SUCCESS (2.044s)
[479.555383] Starting dynamic subtest: vcs1
[481.498562] Dynamic subtest vcs1: SUCCESS (1.981s)
[481.538580] Starting dynamic subtest: vecs0
[483.482776] Dynamic subtest vecs0: SUCCESS (1.981s)
[483.524706] Starting dynamic subtest: ccs0
[485.466839] Dynamic subtest ccs0: SUCCESS (1.981s)
[485.470619] Subtest engine-engine-error: SUCCESS (11.223s)
[485.689698] [030/142] (528s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted)
[486.070808] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted
[486.074391] Subtest invalid-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.002s)
[486.244982] [031/142] (527s left) gem_exec_whisper (basic-queues)
[486.659284] Starting subtest: basic-queues
[503.529381] Subtest basic-queues: SUCCESS (16.865s)
[504.028436] [032/142] (510s left) vgem_basic (bad-pad)
[504.424633] Starting subtest: bad-pad
[504.427700] Subtest bad-pad: SUCCESS (0.000s)
[504.556802] [033/142] (509s left) kms_cursor_crc (cursor-onscreen-256x85)
[505.679516] Starting subtest: cursor-onscreen-256x85
[505.710368] Starting dynamic subtest: pipe-A-eDP-1
[509.713257] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.998s)
[509.815988] Starting dynamic subtest: pipe-D-eDP-1
[513.280626] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.512s)
[513.283158] Subtest cursor-onscreen-256x85: SUCCESS (7.601s)
[514.230550] [034/142] (500s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[514.735728] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[514.743173] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.001s)
[514.900540] [035/142] (499s left) gem_exec_fence (syncobj-timeline-chain-engines)
[516.921718] Starting subtest: syncobj-timeline-chain-engines
[517.275896] Subtest syncobj-timeline-chain-engines: SUCCESS (0.354s)
[517.714884] [036/142] (496s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[518.672244] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[518.678605] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[519.891710] [037/142] (494s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[520.289311] Subtest tiled-to-tiled: SKIP (0.000s)
[520.413359] [038/142] (494s left) i915_pm_rpm (debugfs-forcewake-user)
[522.727484] Starting subtest: debugfs-forcewake-user
[536.587299] Subtest debugfs-forcewake-user: SUCCESS (13.859s)
[537.194574] [039/142] (477s left) gem_exec_balancer (waits)
[537.611485] Starting subtest: waits
[547.537024] Subtest waits: SUCCESS (9.925s)
[548.578109] [040/142] (466s left) kms_pwrite_crc
[551.521247] [041/142] (463s left) kms_plane_multiple (tiling-y)
[551.913797] Starting subtest: tiling-y
[551.921093] Subtest tiling-y: SKIP (0.000s)
[552.025238] [042/142] (462s left) kms_vblank (pipe-d-ts-continuation-suspend)
[552.268234] Starting subtest: pipe-D-ts-continuation-suspend
[570.996072] Subtest pipe-D-ts-continuation-suspend: SUCCESS (18.725s)
[571.937875] [043/142] (443s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[572.393403] Starting subtest: map-fixed-invalidate-overlap-busy
[572.400432] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[572.621587] [044/142] (442s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[573.114275] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[573.121676] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[573.289349] [045/142] (441s left) kms_chamelium_edid (vga-edid-read)
[574.072921] Subtest vga-edid-read: SKIP (0.000s)
[574.948294] [046/142] (440s left) i915_module_load (load)
[575.311572] Starting subtest: load
[575.324629] Subtest load: SKIP (0.005s)
[575.454943] [047/142] (439s left) kms_content_protection (lic)
[576.131786] Starting subtest: LIC
[580.064897] Subtest LIC: SKIP (3.933s)
[581.436653] [048/142] (433s left) gem_exec_flush (basic-batch-kernel-default-uc)
[581.867530] Starting subtest: basic-batch-kernel-default-uc
[590.722514] Subtest basic-batch-kernel-default-uc: SUCCESS (8.859s)
[591.038130] [049/142] (424s left) gem_mmap_gtt (basic-write-gtt)
[591.411482] Subtest basic-write-gtt: SKIP (0.000s)
[591.547897] [050/142] (423s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[592.626367] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[592.633108] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[593.897955] [051/142] (421s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[594.355607] Starting subtest: map-fixed-invalidate-overlap
[594.362615] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[594.598527] [052/142] (421s left) gem_exec_gttfill (all-engines)
[595.026184] Starting subtest: all-engines
[627.517564] Subtest all-engines: SUCCESS (32.489s)
[627.793689] [053/142] (388s left) syncobj_basic (bad-handle-to-fd)
[628.307475] Starting subtest: bad-handle-to-fd
[628.310782] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[628.472873] [054/142] (387s left) gem_ctx_param (invalid-param-get)
[628.850882] Starting subtest: invalid-param-get
[628.855570] Subtest invalid-param-get: SUCCESS (0.003s)
[629.031219] [055/142] (386s left) kms_addfb_basic (unused-handle)
[629.407521] Starting subtest: unused-handle
[629.410663] Subtest unused-handle: SUCCESS (0.000s)
[629.722457] [056/142] (386s left) perf (invalid-oa-format-id)
[630.467944] Starting subtest: invalid-oa-format-id
[630.518730] Subtest invalid-oa-format-id: SUCCESS (0.051s)
[630.637814] [057/142] (385s left) kms_force_connector_basic (force-load-detect)
[631.037252] Starting subtest: force-load-detect
[631.045204] Subtest force-load-detect: SKIP (0.000s)
[631.265138] [058/142] (385s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[631.829901] Starting subtest: 4-tiled-16bpp-rotate-90
[631.891826] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.058s)
[632.094762] [059/142] (384s left) kms_big_fb (linear-32bpp-rotate-180)
[632.626471] Starting subtest: linear-32bpp-rotate-180
[638.185064] Subtest linear-32bpp-rotate-180: SUCCESS (5.555s)
[638.631231] [060/142] (377s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[639.506586] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[640.377119] [061/142] (376s left) kms_busy (extended-modeset-hang-oldfb)
[640.865962] Starting subtest: extended-modeset-hang-oldfb
[640.874344] Starting dynamic subtest: pipe-A
[656.579465] Dynamic subtest pipe-A: SUCCESS (15.707s)
[656.652361] Starting dynamic subtest: pipe-D
[672.996658] Dynamic subtest pipe-D: SUCCESS (16.389s)
[673.000367] Subtest extended-modeset-hang-oldfb: SUCCESS (32.133s)
[673.962159] [062/142] (342s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[674.469675] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[689.583801] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (15.123s)
[689.863311] [063/142] (326s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[690.378563] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[690.385476] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[690.548977] [064/142] (326s left) prime_vgem (basic-read)
[690.958579] Starting subtest: basic-read
[690.997915] Subtest basic-read: SKIP (0.036s)
[691.178627] [065/142] (325s left) gem_ctx_param (invalid-size-set)
[691.544406] Starting subtest: invalid-size-set
[691.547443] Subtest invalid-size-set: SUCCESS (0.002s)
[691.699073] [066/142] (325s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[692.206302] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[692.213388] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[692.383245] [067/142] (324s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[692.943975] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[692.951365] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[693.092748] [068/142] (324s left) dmabuf_sync_file (export-basic)
[693.468788] Starting subtest: export-basic
[693.478769] Subtest export-basic: SUCCESS (0.004s)
[693.611777] [069/142] (323s left) perf (stress-open-close)
[694.216459] Starting subtest: stress-open-close
[694.220895] Starting dynamic subtest: 0-rcs0
[696.491892] Dynamic subtest 0-rcs0: SUCCESS (2.274s)
[696.551166] Starting dynamic subtest: 1-vcs1
[698.764285] Dynamic subtest 1-vcs1: SUCCESS (2.267s)
[698.767980] Subtest stress-open-close: SUCCESS (4.551s)
[698.872616] [070/142] (318s left) kms_psr2_su (frontbuffer-xrgb8888)
[699.266709] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[699.392995] [071/142] (318s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_ccs)
[700.474482] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_ccs
[700.481338] Subtest pipe-B-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[701.202206] [072/142] (316s left) kms_flip (basic-flip-vs-wf_vblank)
[701.615457] Starting subtest: basic-flip-vs-wf_vblank
[701.644855] Starting dynamic subtest: A-eDP1
[704.148499] Dynamic subtest A-eDP1: SUCCESS (2.504s)
[704.193977] Starting dynamic subtest: B-eDP1
[706.420241] Dynamic subtest B-eDP1: SUCCESS (2.267s)
[706.479562] Starting dynamic subtest: C-eDP1
[708.721580] Dynamic subtest C-eDP1: SUCCESS (2.293s)
[708.768540] Starting dynamic subtest: D-eDP1
[710.834131] Dynamic subtest D-eDP1: SUCCESS (2.109s)
[710.842543] Subtest basic-flip-vs-wf_vblank: SUCCESS (9.233s)
[712.295498] [073/142] (305s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs)
[713.256081] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs
[713.262240] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[714.589923] [074/142] (303s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[715.123467] Starting subtest: yf-tiled-32bpp-rotate-0
[715.130508] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[715.312096] [075/142] (302s left) i915_pm_rpm (pc8-residency)
[717.633756] Starting subtest: pc8-residency
[717.640751] Subtest pc8-residency: SKIP (0.000s)
[718.471441] [076/142] (299s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[718.863351] Starting subtest: invalid-multi-wait-unsubmitted
[718.867812] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.001s)
[719.032101] [077/142] (299s left) gem_mmap_gtt (big-copy-odd)
[719.402111] Subtest big-copy-odd: SKIP (0.000s)
[719.527070] [078/142] (298s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[720.010691] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[720.020119] Starting dynamic subtest: pipe-A-eDP-1
[722.440540] Dynamic subtest pipe-A-eDP-1: SKIP (2.415s)
[722.494309] Starting dynamic subtest: pipe-B-eDP-1
[726.212931] Dynamic subtest pipe-B-eDP-1: SKIP (3.763s)
[726.272137] Starting dynamic subtest: pipe-C-eDP-1
[728.120246] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.901s)
[728.151230] Starting dynamic subtest: pipe-D-eDP-1
[730.060632] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.938s)
[730.064265] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (10.053s)
[731.566642] [079/142] (286s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs)
[733.168193] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs
[733.174906] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[733.941109] [080/142] (284s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[735.177327] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[735.181070] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.002s)
[736.327527] [081/142] (282s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[736.724844] Starting subtest: single-wait-for-submit-unsubmitted
[736.833053] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[736.993213] [082/142] (281s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[738.669764] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[738.675715] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[739.410405] [083/142] (279s left) kms_psr (psr2_sprite_render)
[739.891959] Starting subtest: psr2_sprite_render
[743.093925] Subtest psr2_sprite_render: SUCCESS (3.198s)
[744.043639] [084/142] (274s left) syncobj_timeline (signal-array)
[744.437064] Starting subtest: signal-array
[744.441399] Subtest signal-array: SUCCESS (0.002s)
[744.597894] [085/142] (274s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[745.106415] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[745.113235] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[745.282525] [086/142] (273s left) drm_fdinfo (all-busy-check-all)
[745.678618] Starting subtest: all-busy-check-all
[745.694841] Subtest all-busy-check-all: SKIP (0.012s)
[745.845507] [087/142] (273s left) vc4/vc4_label_bo (set-bad-name)
[746.317158] Subtest set-bad-name: SKIP (0.000s)
[746.459871] [088/142] (272s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[746.930224] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[747.072549] [089/142] (272s left) kms_cursor_crc (cursor-random-64x21)
[747.920354] Starting subtest: cursor-random-64x21
[747.953616] Starting dynamic subtest: pipe-A-eDP-1
[753.300949] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.347s)
[753.393160] Starting dynamic subtest: pipe-D-eDP-1
[759.090899] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.753s)
[759.095399] Subtest cursor-random-64x21: SUCCESS (11.176s)
[760.131626] [090/142] (259s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[760.643496] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[772.810044] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (12.170s)
[773.006671] [091/142] (246s left) kms_psr (sprite_mmap_gtt)
[773.502862] Starting subtest: sprite_mmap_gtt
[776.206713] Subtest sprite_mmap_gtt: SKIP (2.700s)
[776.599079] [092/142] (242s left) core_auth (basic-auth)
[776.974889] Starting subtest: basic-auth
[776.979490] Subtest basic-auth: SUCCESS (0.004s)
[777.141922] [093/142] (242s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[777.691229] Starting subtest: x-tiled-8bpp-rotate-180
[781.216380] Subtest x-tiled-8bpp-rotate-180: SUCCESS (3.523s)
[781.580441] [094/142] (238s left) gem_ctx_persistence (hang)
[781.979405] Starting subtest: hang
[781.985909] Subtest hang: SKIP (0.001s)
[782.170105] [095/142] (237s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[782.675976] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[782.682644] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[782.853971] [096/142] (237s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[783.238997] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[783.344833] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[783.497514] [097/142] (236s left) kms_vblank (pipe-c-ts-continuation-idle-hang)
[783.977403] Starting subtest: pipe-C-ts-continuation-idle-hang
[799.869114] Subtest pipe-C-ts-continuation-idle-hang: SUCCESS (15.891s)
[800.816154] [098/142] (219s left) perf (create-destroy-userspace-config)
[801.430992] Starting subtest: create-destroy-userspace-config
[801.527545] Subtest create-destroy-userspace-config: SUCCESS (0.097s)
[801.645185] [099/142] (218s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_mc_ccs)
[803.107290] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs
[807.293517] Subtest pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs: SUCCESS (4.185s)
[808.639390] [100/142] (211s left) kms_prime (basic-crc-hybrid)
[812.549655] Subtest basic-crc-hybrid: SKIP (0.000s)
[812.740721] [101/142] (207s left) perf_pmu (busy-idle-no-semaphores)
[813.145817] Starting subtest: busy-idle-no-semaphores
[813.149655] Starting dynamic subtest: rcs0
[813.835986] Dynamic subtest rcs0: SUCCESS (0.687s)
[813.891247] Starting dynamic subtest: bcs0
[814.521819] Dynamic subtest bcs0: SUCCESS (0.681s)
[814.573232] Starting dynamic subtest: vcs0
[815.206867] Dynamic subtest vcs0: SUCCESS (0.680s)
[815.259676] Starting dynamic subtest: vcs1
[817.110710] Dynamic subtest vcs1: SUCCESS (1.899s)
[817.163466] Starting dynamic subtest: vecs0
[819.092497] Dynamic subtest vecs0: SUCCESS (1.977s)
[819.144573] Starting dynamic subtest: ccs0
[821.142165] Dynamic subtest ccs0: SUCCESS (2.045s)
[821.146279] Subtest busy-idle-no-semaphores: SUCCESS (7.997s)
[821.378250] [102/142] (199s left) gem_ppgtt (blt-vs-render-ctxn)
[821.776486] Starting subtest: blt-vs-render-ctxN
[856.934837] Subtest blt-vs-render-ctxN: SUCCESS (35.156s)
[857.143368] [103/142] (163s left) gem_mmap_gtt (medium-copy-xy)
[857.669438] Subtest medium-copy-XY: SKIP (0.000s)
[857.805647] [104/142] (162s left) kms_invalid_mode (zero-clock)
[858.315576] Starting subtest: zero-clock
[858.319123] Starting dynamic subtest: eDP-1-pipe-A
[858.734355] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.417s)
[858.796254] Starting dynamic subtest: eDP-1-pipe-B
[858.799953] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.043s)
[858.844174] Starting dynamic subtest: eDP-1-pipe-C
[858.849158] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.034s)
[858.901827] Starting dynamic subtest: eDP-1-pipe-D
[858.905423] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.042s)
[858.908633] Subtest zero-clock: SUCCESS (0.570s)
[859.656550] [105/142] (161s left) gen9_exec_parse (basic-rejected-ctx-param)
[860.072574] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[860.209653] [106/142] (160s left) gem_create (create-ext-set-pat)
[860.744867] Starting subtest: create-ext-set-pat
[860.749379] Subtest create-ext-set-pat: SUCCESS (0.002s)
[860.921504] [107/142] (159s left) gem_exec_reloc (basic-write-cpu-active)
[861.334511] Subtest basic-write-cpu-active: SKIP (0.000s)
[861.494875] [108/142] (159s left) gem_mmap_offset (ptrace)
[861.883638] Starting subtest: ptrace
[861.896929] Starting dynamic subtest: smem0-wb
[862.042138] Dynamic subtest smem0-wb: SUCCESS (0.149s)
[862.094216] Starting dynamic subtest: smem0-wc
[862.202459] Dynamic subtest smem0-wc: SUCCESS (0.156s)
[862.260905] Starting dynamic subtest: smem0-uc
[862.369582] Dynamic subtest smem0-uc: SUCCESS (0.162s)
[862.373600] Subtest ptrace: SUCCESS (0.493s)
[862.530521] [109/142] (158s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[863.034240] Starting subtest: disable-crc-after-crtc
[863.043787] Starting dynamic subtest: pipe-A-eDP-1
[865.287532] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.240s)
[865.352426] Starting dynamic subtest: pipe-B-eDP-1
[868.151366] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.851s)
[868.204187] Starting dynamic subtest: pipe-C-eDP-1
[871.293512] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.135s)
[871.352671] Starting dynamic subtest: pipe-D-eDP-1
[874.742887] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.435s)
[874.747184] Subtest disable-crc-after-crtc: SUCCESS (11.707s)
[875.703634] [110/142] (145s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[876.246702] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[876.253884] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[876.421550] [111/142] (144s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[876.932476] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[890.844409] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (13.918s)
[891.042934] [112/142] (130s left) gem_pread (self)
[891.416265] Subtest self: SKIP (0.000s)
[891.551794] [113/142] (129s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[892.039925] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[897.064696] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (5.032s)
[897.333368] [114/142] (124s left) gem_mmap_gtt (basic-wc)
[897.704843] Subtest basic-wc: SKIP (0.000s)
[897.827609] [115/142] (123s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs)
[898.673239] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs
[898.680119] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[900.112546] [116/142] (121s left) kms_flip (2x-dpms-vs-vblank-race)
[900.499338] Starting subtest: 2x-dpms-vs-vblank-race
[900.660207] Subtest 2x-dpms-vs-vblank-race: SKIP (0.159s)
[900.870339] [117/142] (120s left) kms_chamelium_hpd (vga-hpd)
[901.732335] Subtest vga-hpd: SKIP (0.000s)
[902.639915] [118/142] (119s left) gem_ctx_engines (execute-one)
[903.086427] Starting subtest: execute-one
[911.905344] Subtest execute-one: SUCCESS (8.819s)
[912.270844] [119/142] (109s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[913.791259] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[916.963269] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (3.172s)
[918.356674] [120/142] (103s left) kms_flip_event_leak (basic)
[918.849601] Starting subtest: basic
[918.853404] Starting dynamic subtest: pipe-A-eDP-1
[919.481940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.628s)
[919.541354] Starting dynamic subtest: pipe-B-eDP-1
[920.936645] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.443s)
[920.996126] Starting dynamic subtest: pipe-C-eDP-1
[922.734501] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.788s)
[922.798162] Starting dynamic subtest: pipe-D-eDP-1
[924.899159] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.156s)
[924.903044] Subtest basic: SUCCESS (6.053s)
[925.864632] [121/142] ( 96s left) gem_exec_fence (keep-in-fence)
[926.457711] Starting subtest: keep-in-fence
[926.461554] Starting dynamic subtest: rcs0
[926.542421] Dynamic subtest rcs0: SUCCESS (0.083s)
[926.595534] Starting dynamic subtest: bcs0
[926.621720] Dynamic subtest bcs0: SUCCESS (0.075s)
[926.665209] Starting dynamic subtest: vcs0
[928.488629] Dynamic subtest vcs0: SUCCESS (1.862s)
[928.543573] Starting dynamic subtest: vcs1
[930.471517] Dynamic subtest vcs1: SUCCESS (1.979s)
[930.529625] Starting dynamic subtest: vecs0
[932.523133] Dynamic subtest vecs0: SUCCESS (2.047s)
[932.577498] Starting dynamic subtest: ccs0
[934.267523] Dynamic subtest ccs0: SUCCESS (1.741s)
[934.271457] Subtest keep-in-fence: SUCCESS (7.812s)
[936.640584] [122/142] ( 85s left) gem_exec_params (sol-reset-invalid)
[937.045274] Starting subtest: sol-reset-invalid
[937.055235] Subtest sol-reset-invalid: SUCCESS (0.008s)
[938.711764] [123/142] ( 83s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[939.231442] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[939.241448] Starting dynamic subtest: pipe-A-default-mode
[939.648713] Dynamic subtest pipe-A-default-mode: SKIP (0.401s)
[939.656562] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.412s)
[940.591860] [124/142] ( 81s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[941.012963] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[941.020408] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[941.306227] [125/142] ( 81s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[941.796339] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[941.801612] Starting dynamic subtest: pipe-A-eDP-1
[942.017957] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.217s)
[942.079382] Starting dynamic subtest: pipe-B-eDP-1
[943.550912] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.521s)
[943.611474] Starting dynamic subtest: pipe-C-eDP-1
[945.062521] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.501s)
[945.125062] Starting dynamic subtest: pipe-D-eDP-1
[946.545237] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.472s)
[946.548320] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (4.756s)
[948.078947] [126/142] ( 74s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[949.450080] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[949.456624] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[950.517655] [127/142] ( 72s left) v3d/v3d_submit_cl (bad-multisync-pad)
[951.012184] Subtest bad-multisync-pad: SKIP (0.000s)
[951.150607] [128/142] ( 71s left) perf (i915-ref-count)
[951.730294] Starting subtest: i915-ref-count
[951.876975] Subtest i915-ref-count: SUCCESS (0.147s)
[952.093226] [129/142] ( 70s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[952.593973] Starting subtest: psr-rgb565-draw-mmap-cpu
[968.380300] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (15.787s)
[968.681198] [130/142] ( 54s left) gem_exec_schedule (preempt-user)
[969.132870] Starting subtest: preempt-user
[969.136392] Starting dynamic subtest: rcs0
[969.268518] Dynamic subtest rcs0: SUCCESS (0.138s)
[969.327301] Starting dynamic subtest: bcs0
[969.396497] Dynamic subtest bcs0: SUCCESS (0.125s)
[969.451876] Starting dynamic subtest: vcs0
[969.522831] Dynamic subtest vcs0: SUCCESS (0.122s)
[969.575763] Starting dynamic subtest: vcs1
[969.647836] Dynamic subtest vcs1: SUCCESS (0.121s)
[969.701906] Starting dynamic subtest: vecs0
[969.773841] Dynamic subtest vecs0: SUCCESS (0.122s)
[969.829946] Starting dynamic subtest: ccs0
[969.901183] Dynamic subtest ccs0: SUCCESS (0.123s)
[969.905085] Subtest preempt-user: SUCCESS (0.776s)
[970.610986] [131/142] ( 52s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[971.102273] Starting subtest: primary-y-tiled-reflect-x-270
[971.115681] Subtest primary-y-tiled-reflect-x-270: SKIP (0.007s)
[971.271093] [132/142] ( 52s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render)
[971.778394] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render
[986.090360] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SUCCESS (14.320s)
[986.380295] [133/142] ( 37s left) i915_suspend (forcewake)
[986.754157] Starting subtest: forcewake
[1020.581138] Subtest forcewake: SUCCESS (33.825s)
[1020.717987] [134/142] (  2s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[1021.892223] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[1021.899845] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[1023.087157] [135/142] (  0s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[1023.610837] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[1023.617679] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[1023.780192] Overall timeout time exceeded, stopping.
[1023.781491] Closing watchdogs
Done.