[51.127927] Initializing watchdogs
[51.128178]   /dev/watchdog0
[51.143710] [001/142] (960s left) kms_vblank (pipe-c-query-busy-hang)
[51.401595] Starting subtest: pipe-C-query-busy-hang
[59.004775] Subtest pipe-C-query-busy-hang: SUCCESS (7.603s)
[59.368257] [002/142] (952s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[59.517231] Starting subtest: invalid-multi-wait-all-unsubmitted
[59.518637] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[59.596282] [003/142] (952s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[59.867864] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[59.873968] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.004s)
[59.960765] [004/142] (951s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[60.212489] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[60.214943] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[60.294254] [005/142] (951s left) gem_exec_schedule (thriceslice)
[60.476158] Starting subtest: thriceslice
[60.477576] Starting dynamic subtest: rcs0
[60.494459] Dynamic subtest rcs0: SUCCESS (0.019s)
[60.515655] Starting dynamic subtest: bcs0
[60.517223] Dynamic subtest bcs0: SUCCESS (0.018s)
[60.535791] Starting dynamic subtest: vcs0
[60.537427] Dynamic subtest vcs0: SUCCESS (0.013s)
[60.552829] Starting dynamic subtest: vecs0
[60.554293] Dynamic subtest vecs0: SUCCESS (0.011s)
[60.555757] Subtest thriceslice: SUCCESS (0.064s)
[60.895174] [006/142] (950s left) gem_exec_schedule (preempt-queue)
[61.067678] Starting subtest: preempt-queue
[61.069449] Starting dynamic subtest: rcs0
[61.483989] Dynamic subtest rcs0: SUCCESS (0.417s)
[61.501322] Starting dynamic subtest: bcs0
[61.893357] Dynamic subtest bcs0: SUCCESS (0.408s)
[61.910606] Starting dynamic subtest: vcs0
[62.298989] Dynamic subtest vcs0: SUCCESS (0.405s)
[62.314584] Starting dynamic subtest: vecs0
[62.705072] Dynamic subtest vecs0: SUCCESS (0.405s)
[62.706611] Subtest preempt-queue: SUCCESS (1.638s)
[63.065498] [007/142] (948s left) kms_atomic_interruptible (legacy-pageflip)
[63.311136] Starting subtest: legacy-pageflip
[63.314820] Starting dynamic subtest: DP-1-pipe-A
[69.864332] Dynamic subtest DP-1-pipe-A: SUCCESS (6.549s)
[69.865608] Subtest legacy-pageflip: SUCCESS (6.552s)
[70.211194] [008/142] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[70.461824] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[70.464511] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[70.560965] [009/142] (941s left) gem_mmap_gtt (big-bo-tiledx)
[70.701903] Starting subtest: big-bo-tiledX
[72.338884] Subtest big-bo-tiledX: SUCCESS (1.636s)
[72.572513] [010/142] (939s left) perf_pmu (cpu-hotplug)
[72.846530] Starting subtest: cpu-hotplug
[72.851854] Subtest cpu-hotplug: SKIP (0.004s)
[72.944867] [011/142] (939s left) syncobj_timeline (signal)
[73.100572] Starting subtest: signal
[73.102310] Subtest signal: SUCCESS (0.002s)
[73.178051] [012/142] (938s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[73.418381] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[73.419719] Starting dynamic subtest: pipe-A-valid-mode
[73.509293] Dynamic subtest pipe-A-valid-mode: SKIP (0.087s)
[73.511829] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.089s)
[73.817420] [013/142] (938s left) kms_cursor_legacy (torture-bo)
[74.077799] Starting subtest: torture-bo
[74.079331] Starting dynamic subtest: pipe-A
[79.734785] Dynamic subtest pipe-A: SUCCESS (5.655s)
[79.757414] Starting dynamic subtest: pipe-B
[85.379378] Dynamic subtest pipe-B: SUCCESS (5.645s)
[85.394298] Starting dynamic subtest: pipe-C
[90.952877] Dynamic subtest pipe-C: SUCCESS (5.573s)
[90.968920] Starting dynamic subtest: all-pipes
[96.563299] Dynamic subtest all-pipes: SUCCESS (5.611s)
[96.564558] Subtest torture-bo: SUCCESS (22.486s)
[96.653040] [014/142] (915s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[97.008284] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[97.010956] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[97.436112] [015/142] (914s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[97.784637] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[97.787162] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[98.221710] [016/142] (913s left) gem_pxp (create-regular-context-1)
[100.883864] Subtest create-regular-context-1: SKIP (0.000s)
[100.970218] [017/142] (911s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[101.111968] Starting subtest: invalid-bsd1-flag-on-blt
[101.113814] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.001s)
[101.204228] [018/142] (911s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[101.442560] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[101.445453] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.002s)
[101.520600] [019/142] (910s left) gem_ppgtt (blt-vs-render-ctxn)
[101.673139] Starting subtest: blt-vs-render-ctxN
[134.308399] Subtest blt-vs-render-ctxN: SUCCESS (32.634s)
[134.427763] [020/142] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[134.807211] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[134.810027] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[134.905094] [021/142] (877s left) i915_query (engine-info-invalid)
[135.046890] Starting subtest: engine-info-invalid
[135.048448] Subtest engine-info-invalid: SUCCESS (0.000s)
[135.121670] [022/142] (877s left) kms_cursor_edge_walk (64x64-top-edge)
[135.360212] Starting subtest: 64x64-top-edge
[135.361498] Starting dynamic subtest: pipe-A-DP-1
[139.219829] Dynamic subtest pipe-A-DP-1: SUCCESS (3.859s)
[139.237063] Starting dynamic subtest: pipe-C-DP-1
[142.708814] Dynamic subtest pipe-C-DP-1: SUCCESS (3.487s)
[142.710386] Subtest 64x64-top-edge: SUCCESS (7.351s)
[143.018818] [023/142] (869s left) kms_mmap_write_crc (main)
[143.277965] Starting subtest: main
[143.281622] Starting dynamic subtest: pipe-A-DP-1
[146.694621] Dynamic subtest pipe-A-DP-1: SUCCESS (3.413s)
[146.696094] Subtest main: SUCCESS (3.416s)
[147.065909] [024/142] (865s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs)
[147.308495] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs
[147.312335] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[147.884139] [025/142] (864s left) gem_render_copy_redux (interruptible)
[148.041960] Starting subtest: interruptible
[150.386828] Subtest interruptible: SUCCESS (2.343s)
[150.468219] [026/142] (862s left) gem_exec_balancer (full-late)
[150.630934] Starting subtest: full-late
[154.595105] Subtest full-late: SUCCESS (3.964s)
[158.503546] [027/142] (854s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[158.763194] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[160.183668] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.420s)
[160.322437] [028/142] (852s left) kms_flip (absolute-wf_vblank)
[160.548617] Starting subtest: absolute-wf_vblank
[160.553029] Starting dynamic subtest: A-DP1
[171.072038] Dynamic subtest A-DP1: SUCCESS (10.521s)
[171.089415] Starting dynamic subtest: B-DP1
[181.535511] Dynamic subtest B-DP1: SUCCESS (10.461s)
[181.553093] Starting dynamic subtest: C-DP1
[192.157495] Dynamic subtest C-DP1: SUCCESS (10.623s)
[192.159199] Subtest absolute-wf_vblank: SUCCESS (31.613s)
[192.591526] [029/142] (820s left) kms_content_protection (dp-mst-lic-type-0)
[192.868937] Starting subtest: dp-mst-lic-type-0
[192.871711] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[192.970993] [030/142] (819s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[193.208195] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[193.212184] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.003s)
[193.304180] [031/142] (819s left) kms_cdclk (mode-transition)
[193.448736] Subtest mode-transition: SKIP (0.000s)
[193.504636] [032/142] (819s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[193.978674] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[194.290230] [033/142] (818s left) kms_psr (psr2_cursor_mmap_gtt)
[194.430724] Subtest psr2_cursor_mmap_gtt: SKIP (0.000s)
[194.473789] [034/142] (818s left) i915_pm_freq_api (freq-reset-multiple)
[194.619867] Subtest freq-reset-multiple: SKIP (0.000s)
[194.676897] [035/142] (818s left) gem_mmap_offset (bad-extensions)
[194.816843] Starting subtest: bad-extensions
[194.818284] Subtest bad-extensions: SUCCESS (0.000s)
[194.906296] [036/142] (817s left) gem_lmem_swapping (verify-ccs)
[195.055163] Subtest verify-ccs: SKIP (0.000s)
[195.110508] [037/142] (817s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[195.583188] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[195.902131] [038/142] (817s left) kms_sequence (queue-busy)
[196.141777] Starting subtest: queue-busy
[196.143603] Starting dynamic subtest: DP-1-pipe-A
[198.625248] Dynamic subtest DP-1-pipe-A: SUCCESS (2.484s)
[198.645042] Starting dynamic subtest: DP-1-pipe-B
[201.276831] Dynamic subtest DP-1-pipe-B: SUCCESS (2.649s)
[201.293689] Starting dynamic subtest: DP-1-pipe-C
[203.922801] Dynamic subtest DP-1-pipe-C: SUCCESS (2.643s)
[203.924461] Subtest queue-busy: SUCCESS (7.783s)
[204.241270] [039/142] (808s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[204.440258] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[204.507309] [040/142] (808s left) gem_exec_reloc (basic-write-gtt-noreloc)
[204.655640] Starting subtest: basic-write-gtt-noreloc
[204.664846] Subtest basic-write-gtt-noreloc: SUCCESS (0.009s)
[204.840985] [041/142] (808s left) kms_getfb (getfb2-handle-closed)
[204.980682] Starting subtest: getfb2-handle-closed
[204.982202] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[205.073427] [042/142] (808s left) i915_hangman (engine-engine-hang)
[205.236973] Starting subtest: engine-engine-hang
[205.238752] Starting dynamic subtest: rcs0
[205.836463] Dynamic subtest rcs0: SUCCESS (0.598s)
[205.855165] Starting dynamic subtest: bcs0
[206.434852] Dynamic subtest bcs0: SUCCESS (0.597s)
[206.454186] Starting dynamic subtest: vcs0
[207.026984] Dynamic subtest vcs0: SUCCESS (0.591s)
[207.045055] Starting dynamic subtest: vecs0
[207.616767] Dynamic subtest vecs0: SUCCESS (0.589s)
[207.618692] Subtest engine-engine-hang: SUCCESS (2.380s)
[207.741694] [043/142] (805s left) i915_pm_rpm (modeset-lpsp)
[209.579748] Starting subtest: modeset-lpsp
[209.846804] Subtest modeset-lpsp: SKIP (0.265s)
[210.328888] [044/142] (802s left) kms_vblank (pipe-d-ts-continuation-idle)
[210.568437] Subtest pipe-D-ts-continuation-idle: SKIP (0.000s)
[210.644516] [045/142] (802s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[210.903572] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[210.906604] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[211.012434] [046/142] (802s left) drm_fdinfo (virtual-busy)
[211.161483] Starting subtest: virtual-busy
[213.339396] Subtest virtual-busy: SUCCESS (2.177s)
[213.427789] [047/142] (799s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[213.571275] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[213.574872] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[213.660632] [048/142] (799s left) gem_partial_pwrite_pread (reads-uncached)
[213.810988] Starting subtest: reads-uncached
[219.936910] Subtest reads-uncached: SUCCESS (6.125s)
[220.045858] [049/142] (793s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[220.281698] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[220.283128] Starting dynamic subtest: pipe-A-DP-1
[220.473120] Dynamic subtest pipe-A-DP-1: SUCCESS (0.190s)
[220.606615] Starting dynamic subtest: pipe-B-DP-1
[221.194171] Dynamic subtest pipe-B-DP-1: SUCCESS (0.621s)
[221.291682] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.011s)
[221.637844] [050/142] (791s left) kms_big_fb (linear-64bpp-rotate-270)
[221.895639] Starting subtest: linear-64bpp-rotate-270
[221.976465] Subtest linear-64bpp-rotate-270: SKIP (0.079s)
[222.086595] [051/142] (791s left) gem_wait (write-wait)
[222.265955] Starting subtest: write-wait
[222.267684] Starting dynamic subtest: all-engines
[223.377345] Dynamic subtest all-engines: SUCCESS (1.109s)
[223.397438] Starting dynamic subtest: rcs0
[224.409834] Dynamic subtest rcs0: SUCCESS (1.033s)
[224.430470] Starting dynamic subtest: bcs0
[225.450614] Dynamic subtest bcs0: SUCCESS (1.040s)
[225.471342] Starting dynamic subtest: vcs0
[226.488352] Dynamic subtest vcs0: SUCCESS (1.036s)
[226.508606] Starting dynamic subtest: vecs0
[227.523792] Dynamic subtest vecs0: SUCCESS (1.034s)
[227.525594] Subtest write-wait: SUCCESS (5.259s)
[227.775381] [052/142] (785s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[228.242705] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[228.245234] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[228.581153] [053/142] (784s left) kms_addfb_basic (bad-pitch-256)
[228.726088] Starting subtest: bad-pitch-256
[228.727447] Subtest bad-pitch-256: SUCCESS (0.000s)
[228.931404] [054/142] (784s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[229.189680] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[229.197163] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.004s)
[229.297680] [055/142] (784s left) prime_vgem (fence-read-hang)
[229.460422] Subtest fence-read-hang: SKIP (0.000s)
[229.565101] [056/142] (784s left) gem_fence_thrash (bo-write-verify-x)
[229.701092] Starting subtest: bo-write-verify-x
[230.880530] Subtest bo-write-verify-x: SUCCESS (1.179s)
[230.986916] [057/142] (782s left) kms_vblank (pipe-b-query-forked-busy-hang)
[231.228701] Starting subtest: pipe-B-query-forked-busy-hang
[238.956084] Subtest pipe-B-query-forked-busy-hang: SUCCESS (7.727s)
[239.301473] [058/142] (774s left) gem_exercise_blt (fast-copy-emit)
[239.455081] Starting subtest: fast-copy-emit
[239.456680] Starting dynamic subtest: linear-smem-smem-emit
[239.512732] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.057s)
[239.533182] Starting dynamic subtest: ymajor-smem-smem-emit
[239.563818] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.050s)
[239.584343] Starting dynamic subtest: yfmajor-smem-smem-emit
[239.612567] Dynamic subtest yfmajor-smem-smem-emit: SUCCESS (0.048s)
[239.633123] Starting dynamic subtest: tile64-smem-smem-emit
[239.661825] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.048s)
[239.663505] Subtest fast-copy-emit: SUCCESS (0.207s)
[239.766263] [059/142] (774s left) core_getversion
[239.982980] [060/142] (773s left) kms_chamelium_frames (hdmi-crc-fast)
[240.310529] Subtest hdmi-crc-fast: SKIP (0.000s)
[240.601254] [061/142] (773s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[240.983184] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[240.986906] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[241.400985] [062/142] (772s left) gem_exec_fence (long-history)
[242.015956] Starting subtest: long-history
[247.783935] Subtest long-history: SUCCESS (5.759s)
[248.414176] [063/142] (765s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_ccs)
[248.874481] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_ccs
[248.879080] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.004s)
[249.190890] [064/142] (764s left) vc4/vc4_perfmon (get-values-invalid-perfmon)
[249.387873] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[249.456439] [065/142] (764s left) kms_invalid_mode (zero-vdisplay)
[249.691213] Starting subtest: zero-vdisplay
[249.692522] Starting dynamic subtest: DP-1-pipe-A
[249.779676] Dynamic subtest DP-1-pipe-A: SUCCESS (0.088s)
[249.800707] Starting dynamic subtest: DP-1-pipe-B
[249.801956] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s)
[249.820947] Starting dynamic subtest: DP-1-pipe-C
[249.822331] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s)
[249.823630] Subtest zero-vdisplay: SUCCESS (0.101s)
[250.116524] [066/142] (763s left) v3d/v3d_submit_csd (bad-extension)
[250.316035] Subtest bad-extension: SKIP (0.000s)
[250.384059] [067/142] (763s left) gem_readwrite (beyond-eob)
[250.524281] Starting subtest: beyond-EOB
[250.527173] Subtest beyond-EOB: SUCCESS (0.000s)
[250.633454] [068/142] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[250.890215] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[250.892978] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[250.983151] [069/142] (763s left) gem_mmap_wc (read)
[251.123439] Starting subtest: read
[251.262198] Subtest read: SUCCESS (0.139s)
[251.349494] [070/142] (762s left) kms_hdmi_inject (inject-4k)
[251.493213] Subtest inject-4k: SKIP (0.000s)
[251.550414] [071/142] (762s left) kms_cursor_crc (cursor-onscreen-512x170)
[251.817697] Starting subtest: cursor-onscreen-512x170
[251.822492] Subtest cursor-onscreen-512x170: SKIP (0.003s)
[251.916380] [072/142] (762s left) drm_read (empty-block)
[252.280820] Starting subtest: empty-block
[253.282167] Subtest empty-block: SUCCESS (1.001s)
[253.384753] [073/142] (760s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[253.800359] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[253.802967] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[254.213297] [074/142] (760s left) prime_vgem (fence-wait)
[254.375410] Starting subtest: fence-wait
[254.377026] Starting dynamic subtest: rcs0
[255.412302] Dynamic subtest rcs0: SUCCESS (1.036s)
[255.432279] Starting dynamic subtest: vcs0
[256.447909] Dynamic subtest vcs0: SUCCESS (1.034s)
[256.466562] Starting dynamic subtest: vecs0
[257.484665] Dynamic subtest vecs0: SUCCESS (1.035s)
[257.487754] Subtest fence-wait: SUCCESS (3.111s)
[257.596821] [075/142] (756s left) perf_pmu (busy-double-start)
[257.743444] Starting subtest: busy-double-start
[257.744940] Starting dynamic subtest: rcs0
[261.288971] Dynamic subtest rcs0: SUCCESS (3.544s)
[261.309138] Starting dynamic subtest: bcs0
[264.848527] Dynamic subtest bcs0: SUCCESS (3.558s)
[264.868354] Starting dynamic subtest: vcs0
[268.398060] Dynamic subtest vcs0: SUCCESS (3.547s)
[268.417636] Starting dynamic subtest: vecs0
[271.947069] Dynamic subtest vecs0: SUCCESS (3.547s)
[271.949053] Subtest busy-double-start: SUCCESS (14.204s)
[272.045978] [076/142] (742s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[272.304964] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[272.307782] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[272.394566] [077/142] (742s left) kms_feature_discovery (display-2x)
[272.636667] Starting subtest: display-2x
[272.639443] Subtest display-2x: SKIP (0.000s)
[272.728250] [078/142] (741s left) kms_plane_scaling (plane-scaler-with-pixel-format-unity-scaling)
[272.965214] Starting subtest: plane-scaler-with-pixel-format-unity-scaling
[272.966495] Starting dynamic subtest: pipe-A-DP-1
[275.338684] Dynamic subtest pipe-A-DP-1: SUCCESS (2.372s)
[275.360635] Starting dynamic subtest: pipe-B-DP-1
[277.963920] Dynamic subtest pipe-B-DP-1: SUCCESS (2.619s)
[277.989356] Starting dynamic subtest: pipe-C-DP-1
[278.350928] Dynamic subtest pipe-C-DP-1: SUCCESS (0.385s)
[278.352377] Subtest plane-scaler-with-pixel-format-unity-scaling: SUCCESS (5.388s)
[278.777822] [079/142] (735s left) i915_suspend (fence-restore-untiled)
[278.917572] Starting subtest: fence-restore-untiled
[298.762664] Subtest fence-restore-untiled: SUCCESS (4.484s)
[301.901871] [080/142] (731s left) gem_busy (extended)
[302.212565] Starting subtest: extended
[302.213892] Starting dynamic subtest: rcs0
[302.235321] Dynamic subtest rcs0: SUCCESS (0.024s)
[302.262229] Starting dynamic subtest: bcs0
[302.263665] Dynamic subtest bcs0: SUCCESS (0.022s)
[302.287932] Starting dynamic subtest: vcs0
[302.289244] Dynamic subtest vcs0: SUCCESS (0.010s)
[302.312036] Starting dynamic subtest: vecs0
[302.313396] Dynamic subtest vecs0: SUCCESS (0.014s)
[302.314786] Subtest extended: SUCCESS (0.077s)
[302.530104] [081/142] (730s left) syncobj_timeline (wait-any-interrupted)
[302.671615] Starting subtest: wait-any-interrupted
[302.778044] Subtest wait-any-interrupted: SUCCESS (0.106s)
[302.863739] [082/142] (730s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[303.105817] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[303.108650] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[303.212208] [083/142] (729s left) gem_exec_params (rsvd2-dirt)
[303.360097] Starting subtest: rsvd2-dirt
[303.363195] Subtest rsvd2-dirt: SKIP (0.000s)
[303.482730] [084/142] (729s left) gem_pread (exhaustion)
[303.621061] Starting subtest: exhaustion
[319.649770] Subtest exhaustion: SUCCESS (16.025s)
[319.766671] [085/142] (713s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[320.032611] Starting subtest: x-tiled-64bpp-rotate-0
[327.638556] Subtest x-tiled-64bpp-rotate-0: SUCCESS (7.605s)
[328.582878] [086/142] (704s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[328.981419] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[328.984113] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[329.388752] [087/142] (703s left) api_intel_allocator (reopen-fork)
[329.530605] Starting subtest: reopen-fork
[332.809548] Subtest reopen-fork: SUCCESS (3.278s)
[332.909119] [088/142] (700s left) syncobj_wait (single-wait-all-submitted)
[333.052727] Starting subtest: single-wait-all-submitted
[333.164814] Subtest single-wait-all-submitted: SUCCESS (0.109s)
[333.257653] [089/142] (700s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[333.512162] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[333.515565] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[333.622386] [090/142] (699s left) gem_ctx_shared (q-promotion)
[333.789735] Starting subtest: Q-promotion
[333.791294] Starting dynamic subtest: rcs0
[333.899677] Dynamic subtest rcs0: SUCCESS (0.106s)
[333.925195] Starting dynamic subtest: bcs0
[334.013343] Dynamic subtest bcs0: SUCCESS (0.113s)
[334.040702] Starting dynamic subtest: vcs0
[334.111729] Dynamic subtest vcs0: SUCCESS (0.096s)
[334.137933] Starting dynamic subtest: vecs0
[334.210892] Dynamic subtest vecs0: SUCCESS (0.097s)
[334.212750] Subtest Q-promotion: SUCCESS (0.422s)
[334.443869] [091/142] (699s left) vc4/vc4_create_bo (create-bo-0)
[334.649114] Subtest create-bo-0: SKIP (0.000s)
[334.722136] [092/142] (698s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[334.965068] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[337.397753] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.434s)
[337.538742] [093/142] (696s left) gem_spin_batch (spin-each)
[337.707926] Starting subtest: spin-each
[341.121481] Subtest spin-each: SUCCESS (3.414s)
[341.356303] [094/142] (692s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs)
[341.770487] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs
[341.773109] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[342.142172] [095/142] (691s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[342.386835] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[342.389876] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[342.491171] [096/142] (691s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[342.652723] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[342.654062] Starting dynamic subtest: smem
[342.965720] Dynamic subtest smem: SUCCESS (0.312s)
[342.967195] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.314s)
[343.178371] [097/142] (690s left) gem_ringfill (basic-all)
[343.593722] Starting subtest: basic-all
[344.786296] Subtest basic-all: SUCCESS (1.193s)
[344.908242] [098/142] (688s left) gem_create (create-ext-set-pat)
[345.182213] Starting subtest: create-ext-set-pat
[345.185494] Subtest create-ext-set-pat: SKIP (0.000s)
[345.277843] [099/142] (688s left) gem_busy (close-race)
[345.443624] Starting subtest: close-race
[367.889615] Subtest close-race: SUCCESS (22.446s)
[368.279280] [100/142] (665s left) kms_chamelium_hpd (dp-hpd-fast)
[368.746864] Subtest dp-hpd-fast: SKIP (0.000s)
[369.042361] [101/142] (664s left) api_intel_bb (reset-bb)
[369.184896] Starting subtest: reset-bb
[369.190282] Subtest reset-bb: SUCCESS (0.006s)
[369.301621] [102/142] (664s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[369.552423] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[369.555182] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[369.651875] [103/142] (664s left) gem_ctx_persistence (engines-persistence)
[369.805671] Starting subtest: engines-persistence
[369.807279] Starting dynamic subtest: rcs0
[370.608265] Dynamic subtest rcs0: SUCCESS (0.802s)
[370.632707] Starting dynamic subtest: bcs0
[371.376367] Dynamic subtest bcs0: SUCCESS (0.765s)
[371.403057] Starting dynamic subtest: vcs0
[372.145357] Dynamic subtest vcs0: SUCCESS (0.766s)
[372.172048] Starting dynamic subtest: vecs0
[372.914579] Dynamic subtest vecs0: SUCCESS (0.766s)
[372.916211] Subtest engines-persistence: SUCCESS (3.109s)
[373.020786] [104/142] (661s left) kms_prop_blob (invalid-get-prop-any)
[373.161528] Starting subtest: invalid-get-prop-any
[373.163244] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[373.253669] [105/142] (660s left) kms_plane (pixel-format)
[373.486567] Starting subtest: pixel-format
[373.487900] Starting dynamic subtest: pipe-A-planes
[380.270809] Dynamic subtest pipe-A-planes: SUCCESS (6.783s)
[380.311322] Starting dynamic subtest: pipe-B-planes
[387.261126] Dynamic subtest pipe-B-planes: SUCCESS (6.985s)
[387.262781] Subtest pixel-format: SUCCESS (13.777s)
[387.623632] [106/142] (646s left) vgem_basic (dmabuf-mmap)
[387.780314] Starting subtest: dmabuf-mmap
[387.820819] Subtest dmabuf-mmap: SUCCESS (0.041s)
[387.893564] [107/142] (646s left) gem_userptr_blits (input-checking)
[388.045807] Starting subtest: input-checking
[388.047291] Subtest input-checking: SUCCESS (0.000s)
[388.223080] [108/142] (646s left) gem_exec_reloc (basic-cpu-active)
[388.374924] Starting subtest: basic-cpu-active
[388.513238] Subtest basic-cpu-active: SUCCESS (0.138s)
[388.707054] [109/142] (645s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_rc_ccs)
[389.087861] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs
[389.090521] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[389.528922] [110/142] (644s left) kms_selftest (drm_damage)
[389.683914] Starting subtest: drm_damage
[389.717926] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_no_damage
[389.720785] Dynamic subtest drm_damage_helper-drm_test_damage_iter_no_damage: SUCCESS (0.000s)
[389.756958] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_no_damage_fractional_src
[389.759481] Dynamic subtest drm_damage_helper-drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.000s)
[389.787122] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_no_damage_src_moved
[389.788355] Dynamic subtest drm_damage_helper-drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.000s)
[389.812627] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_no_damage_fractional_src_moved
[389.813870] Dynamic subtest drm_damage_helper-drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.000s)
[389.837750] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_no_damage_not_visible
[389.839114] Dynamic subtest drm_damage_helper-drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.000s)
[389.864059] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_no_damage_no_crtc
[389.865623] Dynamic subtest drm_damage_helper-drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.000s)
[389.889144] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_no_damage_no_fb
[389.890636] Dynamic subtest drm_damage_helper-drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.000s)
[389.913697] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_simple_damage
[389.914991] Dynamic subtest drm_damage_helper-drm_test_damage_iter_simple_damage: SUCCESS (0.000s)
[389.938667] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_single_damage
[389.939963] Dynamic subtest drm_damage_helper-drm_test_damage_iter_single_damage: SUCCESS (0.000s)
[389.963361] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_single_damage_intersect_src
[389.964651] Dynamic subtest drm_damage_helper-drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.000s)
[389.987886] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_single_damage_outside_src
[389.989187] Dynamic subtest drm_damage_helper-drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.000s)
[390.013880] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_single_damage_fractional_src
[390.015095] Dynamic subtest drm_damage_helper-drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.000s)
[390.038773] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_single_damage_intersect_fractional_src
[390.040144] Dynamic subtest drm_damage_helper-drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.000s)
[390.064222] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_single_damage_outside_fractional_src
[390.065635] Dynamic subtest drm_damage_helper-drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.000s)
[390.089234] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_single_damage_src_moved
[390.090709] Dynamic subtest drm_damage_helper-drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.000s)
[390.114545] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_single_damage_fractional_src_moved
[390.116122] Dynamic subtest drm_damage_helper-drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.000s)
[390.140145] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_damage
[390.141595] Dynamic subtest drm_damage_helper-drm_test_damage_iter_damage: SUCCESS (0.000s)
[390.165160] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_damage_one_intersect
[390.166427] Dynamic subtest drm_damage_helper-drm_test_damage_iter_damage_one_intersect: SUCCESS (0.000s)
[390.189613] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_damage_one_outside
[390.190892] Dynamic subtest drm_damage_helper-drm_test_damage_iter_damage_one_outside: SUCCESS (0.000s)
[390.214728] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_damage_src_moved
[390.216042] Dynamic subtest drm_damage_helper-drm_test_damage_iter_damage_src_moved: SUCCESS (0.000s)
[390.239625] Starting dynamic subtest: drm_damage_helper-drm_test_damage_iter_damage_not_visible
[390.240902] Dynamic subtest drm_damage_helper-drm_test_damage_iter_damage_not_visible: SUCCESS (0.000s)
[390.242375] Subtest drm_damage: SUCCESS (0.092s)
[390.277265] [111/142] (644s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[390.528098] Starting subtest: cursor-rapid-movement-32x10
[390.665751] Subtest cursor-rapid-movement-32x10: SKIP (0.134s)
[390.777129] [112/142] (643s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[391.021909] Starting subtest: fbcpsr-rgb101010-draw-blt
[391.024850] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[391.126861] [113/142] (643s left) kms_atomic (atomic-invalid-params)
[391.654825] Starting subtest: atomic-invalid-params
[391.733069] Subtest atomic-invalid-params: SUCCESS (0.078s)
[392.176543] [114/142] (642s left) gem_ctx_persistence (engines-cleanup)
[392.325984] Starting subtest: engines-cleanup
[392.327499] Starting dynamic subtest: rcs0
[392.367795] Dynamic subtest rcs0: SUCCESS (0.039s)
[392.395638] Starting dynamic subtest: bcs0
[392.404197] Dynamic subtest bcs0: SUCCESS (0.034s)
[392.430558] Starting dynamic subtest: vcs0
[392.447330] Dynamic subtest vcs0: SUCCESS (0.040s)
[392.475262] Starting dynamic subtest: vecs0
[392.486537] Dynamic subtest vecs0: SUCCESS (0.037s)
[392.488121] Subtest engines-cleanup: SUCCESS (0.162s)
[392.579625] [115/142] (641s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[393.058978] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[393.384007] [116/142] (641s left) kms_universal_plane (universal-plane-pipe-a-functional)
[393.620833] Starting subtest: universal-plane-pipe-A-functional
[396.027777] Subtest universal-plane-pipe-A-functional: SUCCESS (2.407s)
[396.353719] [117/142] (638s left) kms_getfb (getfb-repeated-different-handles)
[396.495701] Starting subtest: getfb-repeated-different-handles
[396.497364] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[396.601208] [118/142] (638s left) perf_pmu (semaphore-wait)
[396.749038] Starting subtest: semaphore-wait
[396.750575] Starting dynamic subtest: rcs0
[397.267776] Dynamic subtest rcs0: SUCCESS (0.516s)
[397.294864] Starting dynamic subtest: bcs0
[397.786125] Dynamic subtest bcs0: SUCCESS (0.514s)
[397.811037] Starting dynamic subtest: vcs0
[398.303186] Dynamic subtest vcs0: SUCCESS (0.514s)
[398.330384] Starting dynamic subtest: vecs0
[398.821275] Dynamic subtest vecs0: SUCCESS (0.514s)
[398.823665] Subtest semaphore-wait: SUCCESS (2.073s)
[398.919573] [119/142] (635s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[399.171938] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[399.174972] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[399.285239] [120/142] (635s left) kms_big_fb (yf-tiled-addfb)
[399.555031] Starting subtest: yf-tiled-addfb
[399.556492] Subtest yf-tiled-addfb: SUCCESS (0.000s)
[399.667624] [121/142] (635s left) kms_psr (primary_mmap_gtt)
[399.811891] Subtest primary_mmap_gtt: SKIP (0.000s)
[399.868764] [122/142] (635s left) perf (unprivileged-single-ctx-counters)
[400.149633] Starting subtest: unprivileged-single-ctx-counters
[400.152299] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[400.204188] [123/142] (634s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[400.347768] Starting subtest: invalid-multi-wait-unsubmitted
[400.349198] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[400.435482] [124/142] (634s left) gem_workarounds (basic-read-context)
[400.610600] Starting subtest: basic-read-context
[400.633744] Subtest basic-read-context: SUCCESS (0.023s)
[400.752099] [125/142] (634s left) gem_exec_params (secure-non-root)
[400.901132] Starting subtest: secure-non-root
[400.904306] Subtest secure-non-root: SKIP (0.000s)
[401.017964] [126/142] (634s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[401.254837] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[401.256089] Starting dynamic subtest: pipe-A-valid-mode
[402.022200] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.763s)
[402.023636] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (0.767s)
[402.386357] [127/142] (632s left) kms_rotation_crc (sprite-rotation-90)
[402.632937] Starting subtest: sprite-rotation-90
[408.856837] Subtest sprite-rotation-90: SUCCESS (6.225s)
[409.284323] [128/142] (625s left) gem_exec_gttfill (all-engines)
[409.455865] Starting subtest: all-engines
[450.800974] Subtest all-engines: SUCCESS (41.343s)
[451.005727] [129/142] (584s left) vgem_basic (dmabuf-fence)
[451.274541] Starting subtest: dmabuf-fence
[451.276611] Subtest dmabuf-fence: SUCCESS (0.001s)
[451.351398] [130/142] (583s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[451.612363] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[451.615646] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[451.718129] [131/142] (583s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[451.974566] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[451.977772] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[452.085171] [132/142] (583s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[452.333742] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[452.336502] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[452.435250] [133/142] (582s left) vc4/vc4_tiling (set-get)
[452.660002] Subtest set-get: SKIP (0.000s)
[452.734656] [134/142] (582s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs)
[453.216428] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[453.539253] [135/142] (581s left) gem_exec_params (mmapped)
[453.696255] Starting subtest: mmapped
[453.700612] Subtest mmapped: SUCCESS (0.004s)
[453.821335] [136/142] (581s left) kms_plane_scaling (plane-upscale-with-pixel-format-20x20)
[454.057379] Starting subtest: plane-upscale-with-pixel-format-20x20
[454.062531] Starting dynamic subtest: pipe-A-DP-1
[454.558312] Dynamic subtest pipe-A-DP-1: SUCCESS (0.499s)
[454.586939] Starting dynamic subtest: pipe-B-DP-1
[455.362114] Dynamic subtest pipe-B-DP-1: SUCCESS (0.798s)
[455.390676] Starting dynamic subtest: pipe-C-DP-1
[455.732762] Dynamic subtest pipe-C-DP-1: SUCCESS (0.366s)
[455.734181] Subtest plane-upscale-with-pixel-format-20x20: SUCCESS (1.678s)
[456.154430] [137/142] (579s left) gem_exec_balancer (parallel-bb-first)
[460.171886] Subtest parallel-bb-first: SKIP (0.000s)
[460.270812] [138/142] (575s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[460.525990] Starting subtest: fbcpsr-rgb565-draw-pwrite
[460.528928] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[460.637734] [139/142] (575s left) kms_vblank (pipe-b-query-busy)
[460.875739] Starting subtest: pipe-B-query-busy
[463.662058] Subtest pipe-B-query-busy: SUCCESS (2.788s)
[464.002567] [140/142] (571s left) gem_exec_reloc (basic-write-wc-noreloc)
[464.158329] Starting subtest: basic-write-wc-noreloc
[464.165094] Subtest basic-write-wc-noreloc: SUCCESS (0.007s)
[464.366528] [141/142] (571s left) kms_vblank (pipe-a-query-forked)
[464.603759] Starting subtest: pipe-A-query-forked
[466.952921] Subtest pipe-A-query-forked: SUCCESS (2.349s)
[467.282405] [142/142] (568s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[467.526280] Starting subtest: cursor-vs-flip-toggle
[509.316150] Subtest cursor-vs-flip-toggle: SUCCESS (41.787s)
[509.647212] Closing watchdogs
Done.