[43.756761] Initializing watchdogs
[43.756958]   /dev/watchdog0
[43.791477] [001/138] (960s left) gem_exec_reloc (basic-softpin)
[44.072441] Starting subtest: basic-softpin
[44.105086] Subtest basic-softpin: SUCCESS (0.008s)
[44.294378] [002/138] (960s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[44.609204] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[44.633507] Starting dynamic subtest: pipe-A-valid-mode
[44.752227] Dynamic subtest pipe-A-valid-mode: SKIP (0.100s)
[44.801654] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.102s)
[45.066532] [003/138] (959s left) gem_exec_balancer (semaphore)
[45.307426] Starting subtest: semaphore
[49.661621] Subtest semaphore: SUCCESS (4.187s)
[53.589033] [004/138] (950s left) gem_ctx_engines (execute-allforone)
[53.818382] Starting subtest: execute-allforone
[53.838938] Subtest execute-allforone: SUCCESS (0.019s)
[54.075262] [005/138] (950s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[54.435350] Starting subtest: y-tiled-64bpp-rotate-90
[54.514863] Subtest y-tiled-64bpp-rotate-90: SKIP (0.091s)
[54.626544] [006/138] (950s left) prime_vgem (shrink)
[54.981250] Starting subtest: shrink
[54.999999] Subtest shrink: SUCCESS (0.023s)
[55.106636] [007/138] (949s left) kms_async_flips (test-time-stamp)
[55.388409] Starting subtest: test-time-stamp
[55.581785] Starting dynamic subtest: pipe-A-DP-1
[56.016542] Dynamic subtest pipe-A-DP-1: SUCCESS (0.438s)
[56.228268] Starting dynamic subtest: pipe-B-DP-1
[56.515662] Dynamic subtest pipe-B-DP-1: SUCCESS (0.301s)
[56.695734] Starting dynamic subtest: pipe-C-DP-1
[57.009187] Dynamic subtest pipe-C-DP-1: SUCCESS (0.302s)
[57.028441] Subtest test-time-stamp: SUCCESS (1.605s)
[57.488063] [008/138] (947s left) kms_flip (2x-flip-vs-panning-vs-hang)
[57.810797] Starting subtest: 2x-flip-vs-panning-vs-hang
[57.851856] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.003s)
[57.931647] [009/138] (947s left) kms_plane_scaling (planes-scaler-unity-scaling)
[58.240607] Starting subtest: planes-scaler-unity-scaling
[58.262140] Starting dynamic subtest: pipe-A-DP-1
[58.354086] Dynamic subtest pipe-A-DP-1: SUCCESS (0.094s)
[58.388761] Starting dynamic subtest: pipe-B-DP-1
[58.749897] Dynamic subtest pipe-B-DP-1: SUCCESS (0.383s)
[58.768664] Subtest planes-scaler-unity-scaling: SUCCESS (0.505s)
[59.183458] [010/138] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[59.565062] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[59.601715] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.687758] [011/138] (945s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[60.055586] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[60.097601] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[60.179636] [012/138] (945s left) sysfs_preempt_timeout (idempotent)
[60.413331] Starting subtest: idempotent
[60.434147] Starting dynamic subtest: vecs0
[60.452713] Dynamic subtest vecs0: SUCCESS (0.002s)
[60.483401] Starting dynamic subtest: vcs0
[60.501751] Dynamic subtest vcs0: SUCCESS (0.001s)
[60.532087] Starting dynamic subtest: bcs0
[60.553432] Dynamic subtest bcs0: SUCCESS (0.001s)
[60.586654] Starting dynamic subtest: rcs0
[60.606929] Dynamic subtest rcs0: SUCCESS (0.001s)
[60.627917] Subtest idempotent: SUCCESS (0.009s)
[60.706312] [013/138] (944s left) kms_ccs (pipe-b-bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[61.174995] Starting subtest: pipe-B-bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[61.211567] Subtest pipe-B-bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[61.569893] [014/138] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[61.941848] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[61.980418] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[62.058553] [015/138] (943s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[62.372107] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[62.413721] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.003s)
[62.492458] [016/138] (943s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[62.869798] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[62.906792] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[62.988058] [017/138] (942s left) kms_psr (sprite_mmap_gtt)
[63.238155] Subtest sprite_mmap_gtt: SKIP (0.000s)
[63.323936] [018/138] (942s left) gem_ctx_persistence (smoketest)
[63.559845] Starting subtest: smoketest
[94.667763] Subtest smoketest: SUCCESS (31.130s)
[94.776969] [019/138] (910s left) gem_spin_batch (resubmit)
[94.997243] Starting subtest: resubmit
[95.018896] Starting dynamic subtest: rcs0
[95.039502] Dynamic subtest rcs0: SUCCESS (0.007s)
[95.073943] Starting dynamic subtest: bcs0
[95.092672] Dynamic subtest bcs0: SUCCESS (0.007s)
[95.124431] Starting dynamic subtest: vcs0
[95.143093] Dynamic subtest vcs0: SUCCESS (0.005s)
[95.174774] Starting dynamic subtest: vecs0
[95.196611] Dynamic subtest vecs0: SUCCESS (0.006s)
[95.218222] Subtest resubmit: SUCCESS (0.030s)
[95.302800] [020/138] (910s left) kms_rotation_crc (multiplane-rotation)
[95.602030] Starting subtest: multiplane-rotation
[109.622731] Subtest multiplane-rotation: SUCCESS (14.023s)
[109.773417] [021/138] (896s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[110.093198] Starting subtest: map-fixed-invalidate-overlap-busy
[110.114426] Starting dynamic subtest: gtt
[114.371341] Dynamic subtest gtt: SUCCESS (4.166s)
[114.404050] Starting dynamic subtest: wb
[118.400152] Dynamic subtest wb: SUCCESS (4.026s)
[118.435146] Starting dynamic subtest: wc
[122.447391] Dynamic subtest wc: SUCCESS (4.040s)
[122.480107] Starting dynamic subtest: uc
[126.456975] Dynamic subtest uc: SUCCESS (4.014s)
[126.477434] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (16.252s)
[126.558503] [022/138] (879s left) gem_mmap_gtt (pf-nonblock)
[126.795344] Starting subtest: pf-nonblock
[126.814098] Subtest pf-nonblock: SUCCESS (0.005s)
[126.906164] [023/138] (879s left) sysfs_timeslice_duration (idempotent)
[127.141899] Starting subtest: idempotent
[127.160477] Starting dynamic subtest: vecs0
[127.181901] Dynamic subtest vecs0: SUCCESS (0.001s)
[127.216782] Starting dynamic subtest: vcs0
[127.237361] Dynamic subtest vcs0: SUCCESS (0.001s)
[127.271093] Starting dynamic subtest: bcs0
[127.289753] Dynamic subtest bcs0: SUCCESS (0.001s)
[127.321544] Starting dynamic subtest: rcs0
[127.340139] Dynamic subtest rcs0: SUCCESS (0.002s)
[127.358459] Subtest idempotent: SUCCESS (0.013s)
[127.447682] [024/138] (878s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y-tiled-ccs)
[127.868766] Starting subtest: pipe-A-crc-sprite-planes-basic-y-tiled-ccs
[128.401692] Subtest pipe-A-crc-sprite-planes-basic-y-tiled-ccs: SUCCESS (0.525s)
[128.913328] [025/138] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[129.289163] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[129.326442] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[129.414544] [026/138] (876s left) gem_pxp (protected-raw-src-copy-not-readible)
[132.352395] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[132.475246] [027/138] (873s left) gem_wait (await)
[132.725946] Starting subtest: await
[132.747168] Starting dynamic subtest: all-engines
[133.765352] Dynamic subtest all-engines: SUCCESS (1.050s)
[133.798612] Starting dynamic subtest: rcs0
[134.809416] Dynamic subtest rcs0: SUCCESS (1.027s)
[134.843382] Starting dynamic subtest: bcs0
[135.834989] Dynamic subtest bcs0: SUCCESS (1.029s)
[135.867151] Starting dynamic subtest: vcs0
[136.867342] Dynamic subtest vcs0: SUCCESS (1.029s)
[136.901689] Starting dynamic subtest: vecs0
[137.891928] Dynamic subtest vecs0: SUCCESS (1.027s)
[137.910333] Subtest await: SUCCESS (5.169s)
[138.151923] [028/138] (868s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[138.384812] Starting subtest: invalid-single-wait-unsubmitted
[138.405231] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[138.488823] [029/138] (868s left) gem_exec_whisper (basic-sync)
[138.762683] Starting subtest: basic-sync
[146.848801] Subtest basic-sync: SUCCESS (7.923s)
[146.932116] [030/138] (859s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[147.310214] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[147.347795] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[147.433756] [031/138] (859s left) perf_pmu (busy-accuracy-2)
[147.669366] Starting subtest: busy-accuracy-2
[147.689247] Starting dynamic subtest: rcs0
[150.733786] Dynamic subtest rcs0: SUCCESS (3.068s)
[150.767361] Starting dynamic subtest: bcs0
[153.804886] Dynamic subtest bcs0: SUCCESS (3.069s)
[153.838580] Starting dynamic subtest: vcs0
[156.876738] Dynamic subtest vcs0: SUCCESS (3.063s)
[156.910397] Starting dynamic subtest: vecs0
[159.940742] Dynamic subtest vecs0: SUCCESS (3.067s)
[159.959666] Subtest busy-accuracy-2: SUCCESS (12.273s)
[160.067952] [032/138] (846s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[160.298480] Starting subtest: tiled-to-untiled
[160.421204] Subtest tiled-to-untiled: SUCCESS (0.109s)
[160.541309] [033/138] (846s left) gem_mmap_wc (write-gtt-read-wc)
[160.771956] Starting subtest: write-gtt-read-wc
[161.270468] Subtest write-gtt-read-wc: SUCCESS (0.523s)
[161.398632] [034/138] (845s left) device_reset (unbind-cold-reset-rebind)
[161.654132] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[161.738354] [035/138] (845s left) kms_panel_fitting (legacy)
[162.064799] Starting subtest: legacy
[162.105941] Subtest legacy: SKIP (0.000s)
[162.189226] [036/138] (845s left) kms_vblank (query-forked)
[162.493563] Starting subtest: query-forked
[162.514726] Starting dynamic subtest: pipe-A-DP-1
[164.850652] Dynamic subtest pipe-A-DP-1: SUCCESS (2.345s)
[164.887523] Starting dynamic subtest: pipe-C-DP-1
[167.349392] Dynamic subtest pipe-C-DP-1: SUCCESS (2.501s)
[167.370350] Subtest query-forked: SUCCESS (4.856s)
[167.714748] [037/138] (839s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[168.086792] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[168.126983] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[168.217355] [038/138] (839s left) gem_partial_pwrite_pread (writes-after-reads)
[168.454927] Starting subtest: writes-after-reads
[188.621096] Subtest writes-after-reads: SUCCESS (20.177s)
[188.757550] [039/138] (818s left) kms_atomic_interruptible (atomic-setmode)
[189.086457] Starting subtest: atomic-setmode
[189.107749] Starting dynamic subtest: pipe-A-DP-1
[195.605808] Dynamic subtest pipe-A-DP-1: SUCCESS (6.528s)
[195.630296] Subtest atomic-setmode: SUCCESS (6.532s)
[195.958199] [040/138] (811s left) gem_partial_pwrite_pread (write-snoop)
[196.181371] Starting subtest: write-snoop
[210.058392] Subtest write-snoop: SUCCESS (13.888s)
[210.199555] [041/138] (797s left) kms_big_fb (linear-32bpp-rotate-0)
[210.531058] Starting subtest: linear-32bpp-rotate-0
[216.646119] Subtest linear-32bpp-rotate-0: SUCCESS (6.135s)
[217.183128] [042/138] (790s left) i915_pm_rps (thresholds-idle)
[217.413495] Starting subtest: thresholds-idle
[217.434979] Starting dynamic subtest: gt0
[227.757354] Dynamic subtest gt0: SUCCESS (10.365s)
[227.778553] Subtest thresholds-idle: SUCCESS (10.367s)
[227.888816] [043/138] (779s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[228.239229] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[228.280400] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[228.369311] [044/138] (779s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[228.720601] Starting subtest: psr-rgb565-draw-blt
[228.761254] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[228.847512] [045/138] (779s left) gem_ctx_param (set-priority-not-supported)
[229.087069] Starting subtest: set-priority-not-supported
[229.123960] Subtest set-priority-not-supported: SKIP (0.000s)
[229.213304] [046/138] (778s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[229.535539] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[229.609035] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[229.702096] [047/138] (778s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[229.988950] Starting subtest: addfb25-y-tiled-legacy
[230.009185] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[230.120589] [048/138] (778s left) prime_self_import (basic-with_fd_dup)
[230.341026] Starting subtest: basic-with_fd_dup
[230.378464] Subtest basic-with_fd_dup: SUCCESS (0.006s)
[230.469212] [049/138] (777s left) dumb_buffer (map-invalid-size)
[230.683511] Starting subtest: map-invalid-size
[230.702184] Subtest map-invalid-size: SUCCESS (0.000s)
[230.794129] [050/138] (777s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[231.170830] Starting subtest: fbc-rgb565-draw-pwrite
[233.442210] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.354s)
[233.588563] [051/138] (774s left) kms_ccs (pipe-d-crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[234.143314] Subtest pipe-D-crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[234.467832] [052/138] (774s left) v3d/v3d_wait_bo (used-bo-0ns)
[234.759345] Subtest used-bo-0ns: SKIP (0.000s)
[234.854651] [053/138] (773s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[235.090299] Starting subtest: y-tiled-to-vebox-x-tiled
[235.128780] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[235.296435] [054/138] (773s left) perf (invalid-oa-metric-set-id)
[235.705750] Starting subtest: invalid-oa-metric-set-id
[235.761154] Subtest invalid-oa-metric-set-id: SUCCESS (0.054s)
[235.883620] [055/138] (772s left) gem_ccs (suspend-resume)
[236.137754] Subtest suspend-resume: SKIP (0.000s)
[236.225660] [056/138] (772s left) vgem_basic (setversion)
[236.458534] Starting subtest: setversion
[236.498315] Subtest setversion: SUCCESS (0.000s)
[236.582450] [057/138] (772s left) gem_exec_schedule (preempt)
[236.978693] Starting subtest: preempt
[236.997325] Starting dynamic subtest: rcs0
[237.016328] Dynamic subtest rcs0: SUCCESS (0.065s)
[237.055446] Starting dynamic subtest: bcs0
[237.076736] Dynamic subtest bcs0: SUCCESS (0.088s)
[237.113636] Starting dynamic subtest: vcs0
[237.134070] Dynamic subtest vcs0: SUCCESS (0.060s)
[237.168466] Starting dynamic subtest: vecs0
[237.186957] Dynamic subtest vecs0: SUCCESS (0.060s)
[237.205410] Subtest preempt: SUCCESS (0.283s)
[237.467217] [058/138] (771s left) gem_ppgtt (flink-and-close-vma-leak)
[237.702043] Starting subtest: flink-and-close-vma-leak
[237.722461] Subtest flink-and-close-vma-leak: SUCCESS (0.009s)
[237.829140] [059/138] (771s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[238.209081] Starting subtest: fbcpsr-tiling-linear
[238.246020] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[238.333407] [060/138] (770s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[238.704912] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[238.741403] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[238.841447] [061/138] (770s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[239.174738] Starting subtest: 4-tiled-16bpp-rotate-180
[239.213221] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[239.307061] [062/138] (770s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-dg2-mc-ccs)
[239.742690] Starting subtest: pipe-B-crc-primary-basic-4-tiled-dg2-mc-ccs
[239.784412] Subtest pipe-B-crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.001s)
[240.187346] [063/138] (769s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[240.486688] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[240.523896] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.002s)
[240.614339] [064/138] (769s left) perf_pmu (interrupts-sync)
[240.841974] Starting subtest: interrupts-sync
[241.940042] Subtest interrupts-sync: SUCCESS (1.118s)
[242.067706] [065/138] (767s left) kms_legacy_colorkey (basic)
[242.361648] Starting subtest: basic
[242.383754] Starting dynamic subtest: pipe-A
[242.404798] Dynamic subtest pipe-A: SUCCESS (0.024s)
[242.441671] Starting dynamic subtest: pipe-B
[242.461278] Dynamic subtest pipe-B: SUCCESS (0.001s)
[242.495896] Starting dynamic subtest: pipe-C
[242.514476] Dynamic subtest pipe-C: SUCCESS (0.000s)
[242.532975] Subtest basic: SUCCESS (0.031s)
[242.626720] [066/138] (767s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[242.849985] Starting subtest: invalid-signal-one-illegal-handle
[242.872088] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.001s)
[242.962811] [067/138] (766s left) gem_mmap_offset (close-race)
[243.177110] Starting subtest: close-race
[263.439630] Subtest close-race: SUCCESS (20.124s)
[263.530393] [068/138] (746s left) gem_exec_balancer (bonded-chain)
[263.752462] Starting subtest: bonded-chain
[267.751757] Subtest bonded-chain: SUCCESS (3.826s)
[271.737293] [069/138] (738s left) kms_cursor_crc (cursor-random-128x42)
[272.063229] Starting subtest: cursor-random-128x42
[272.081726] Starting dynamic subtest: pipe-A-DP-1
[275.881574] Dynamic subtest pipe-A-DP-1: SUCCESS (3.803s)
[275.963204] Starting dynamic subtest: pipe-C-DP-1
[279.850316] Dynamic subtest pipe-C-DP-1: SUCCESS (3.907s)
[279.871821] Subtest cursor-random-128x42: SUCCESS (7.791s)
[280.223961] [070/138] (729s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[280.632277] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[280.935734] [071/138] (729s left) kms_prop_blob (invalid-get-prop-any)
[281.173232] Starting subtest: invalid-get-prop-any
[281.192159] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[281.282741] [072/138] (729s left) gem_exec_fence (basic-wait)
[281.648435] Starting subtest: basic-wait
[281.669196] Starting dynamic subtest: rcs0
[281.688064] Dynamic subtest rcs0: SUCCESS (0.029s)
[281.723364] Starting dynamic subtest: bcs0
[281.742054] Dynamic subtest bcs0: SUCCESS (0.021s)
[281.777122] Starting dynamic subtest: vcs0
[281.798665] Dynamic subtest vcs0: SUCCESS (0.033s)
[281.836191] Starting dynamic subtest: vecs0
[281.856580] Dynamic subtest vecs0: SUCCESS (0.030s)
[281.877633] Subtest basic-wait: SUCCESS (0.122s)
[282.461600] [073/138] (728s left) kms_feature_discovery (chamelium)
[282.759424] Starting subtest: chamelium
[282.795696] Subtest chamelium: SKIP (0.001s)
[282.889959] [074/138] (727s left) gem_exec_schedule (timeslicing)
[283.268847] Starting subtest: timeslicing
[283.287669] Starting dynamic subtest: rcs0
[283.306062] Dynamic subtest rcs0: SUCCESS (0.007s)
[283.343141] Starting dynamic subtest: bcs0
[283.374892] Dynamic subtest bcs0: SUCCESS (0.007s)
[283.416441] Starting dynamic subtest: vcs0
[283.446760] Dynamic subtest vcs0: SUCCESS (0.006s)
[283.490364] Starting dynamic subtest: vecs0
[283.516613] Dynamic subtest vecs0: SUCCESS (0.006s)
[283.541532] Subtest timeslicing: SUCCESS (0.036s)
[283.647780] [075/138] (727s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-mc-ccs)
[284.144647] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-mc-ccs
[284.191564] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[284.552864] [076/138] (726s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[284.948042] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[284.998166] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[285.113133] [077/138] (725s left) syncobj_timeline (reset-signaled)
[285.363861] Starting subtest: reset-signaled
[285.388694] Subtest reset-signaled: SUCCESS (0.001s)
[285.505273] [078/138] (725s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-ccs)
[285.925337] Starting subtest: pipe-A-bad-rotation-90-y-tiled-ccs
[286.352851] Subtest pipe-A-bad-rotation-90-y-tiled-ccs: SUCCESS (0.450s)
[286.946202] [079/138] (724s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[287.315944] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[287.358265] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[287.447487] [080/138] (723s left) kms_cursor_crc (cursor-sliding-512x170)
[287.762207] Starting subtest: cursor-sliding-512x170
[287.803536] Subtest cursor-sliding-512x170: SKIP (0.003s)
[287.894837] [081/138] (723s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[288.190050] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[288.208674] Starting dynamic subtest: pipe-A-DP-1
[290.860099] Dynamic subtest pipe-A-DP-1: SUCCESS (2.642s)
[290.897506] Starting dynamic subtest: pipe-B-DP-1
[293.475170] Dynamic subtest pipe-B-DP-1: SUCCESS (2.625s)
[293.516572] Starting dynamic subtest: pipe-C-DP-1
[293.889974] Dynamic subtest pipe-C-DP-1: SUCCESS (0.398s)
[293.909980] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (5.700s)
[294.318375] [082/138] (717s left) perf_pmu (rc6-all-gts)
[294.544686] Starting subtest: rc6-all-gts
[294.586317] Subtest rc6-all-gts: SKIP (0.000s)
[294.697247] [083/138] (716s left) kms_addfb_basic (bad-pitch-0)
[294.924824] Starting subtest: bad-pitch-0
[294.945429] Subtest bad-pitch-0: SUCCESS (0.000s)
[295.117388] [084/138] (716s left) kms_flip (flip-vs-fences)
[295.438329] Starting subtest: flip-vs-fences
[295.457048] Starting dynamic subtest: A-DP1
[306.221826] Dynamic subtest A-DP1: SUCCESS (10.641s)
[306.258925] Starting dynamic subtest: B-DP1
[316.917535] Dynamic subtest B-DP1: SUCCESS (10.867s)
[316.955865] Starting dynamic subtest: C-DP1
[327.976396] Dynamic subtest C-DP1: SUCCESS (10.876s)
[327.995259] Subtest flip-vs-fences: SUCCESS (32.397s)
[328.280990] [085/138] (683s left) kms_ccs (pipe-c-ccs-on-another-bo-y-tiled-ccs)
[328.783130] Starting subtest: pipe-C-ccs-on-another-bo-y-tiled-ccs
[328.827063] Subtest pipe-C-ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s)
[329.144418] [086/138] (682s left) gem_sync (basic-each)
[329.567974] Starting subtest: basic-each
[331.600466] Subtest basic-each: SUCCESS (2.210s)
[331.815110] [087/138] (679s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[332.146966] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[333.682921] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.557s)
[333.881265] [088/138] (677s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[334.115242] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[334.196914] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[334.314207] [089/138] (677s left) kms_cdclk (mode-transition-all-outputs)
[334.564183] Subtest mode-transition-all-outputs: SKIP (0.000s)
[334.679470] [090/138] (677s left) i915_hangman (engine-error-state-capture)
[334.941132] Starting subtest: engine-error-state-capture
[334.964049] Starting dynamic subtest: rcs0
[338.932664] Dynamic subtest rcs0: SUCCESS (3.851s)
[338.975618] Starting dynamic subtest: bcs0
[342.965325] Dynamic subtest bcs0: SUCCESS (4.026s)
[343.004207] Starting dynamic subtest: vcs0
[346.926852] Dynamic subtest vcs0: SUCCESS (3.963s)
[346.966997] Starting dynamic subtest: vecs0
[350.894333] Dynamic subtest vecs0: SUCCESS (3.965s)
[350.916501] Subtest engine-error-state-capture: SUCCESS (15.816s)
[351.022886] [091/138] (661s left) kms_pm_rpm (cursor)
[352.908071] Starting subtest: cursor
[355.561269] Subtest cursor: SUCCESS (2.657s)
[356.035400] [092/138] (656s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[356.330543] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[356.368674] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.002s)
[356.457117] [093/138] (655s left) kms_addfb_basic (invalid-get-prop-any)
[356.682681] Starting subtest: invalid-get-prop-any
[356.701322] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[356.877627] [094/138] (655s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-mtl-rc-ccs)
[357.432951] Subtest pipe-D-bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[357.760935] [095/138] (654s left) kms_lease (lease-unleased-connector)
[358.072648] Starting subtest: lease-unleased-connector
[358.093701] Starting dynamic subtest: pipe-A-DP-1
[358.251843] Dynamic subtest pipe-A-DP-1: SUCCESS (0.163s)
[358.289529] Starting dynamic subtest: pipe-B-DP-1
[358.401295] Dynamic subtest pipe-B-DP-1: SUCCESS (0.160s)
[358.440667] Starting dynamic subtest: pipe-C-DP-1
[358.575089] Dynamic subtest pipe-C-DP-1: SUCCESS (0.159s)
[358.595077] Subtest lease-unleased-connector: SUCCESS (0.496s)
[358.710774] [096/138] (653s left) gem_tiled_fence_blits (normal)
[360.272193] Starting subtest: normal
[362.277161] Subtest normal: SUCCESS (2.003s)
[362.398445] [097/138] (650s left) gem_exec_params (dr1-dirt)
[362.758335] Starting subtest: DR1-dirt
[362.778987] Subtest DR1-dirt: SUCCESS (0.001s)
[362.870232] [098/138] (649s left) kms_selftest (drm_dp_mst)
[363.124085] Starting subtest: drm_dp_mst
[363.201320] Starting dynamic subtest: drm_dp_mst_helper-drm_test_dp_mst_calc_pbn_mode
[363.221415] Dynamic subtest drm_dp_mst_helper-drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.000s)
[363.260034] Starting dynamic subtest: drm_dp_mst_helper-drm_test_dp_mst_sideband_msg_req_decode
[363.281467] Dynamic subtest drm_dp_mst_helper-drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.000s)
[363.301853] Subtest drm_dp_mst: SUCCESS (0.088s)
[363.392919] [099/138] (649s left) gem_exec_fence (parallel)
[363.774786] Starting subtest: parallel
[363.796125] Starting dynamic subtest: rcs0
[365.909885] Dynamic subtest rcs0: SUCCESS (2.152s)
[365.948625] Starting dynamic subtest: bcs0
[368.241945] Dynamic subtest bcs0: SUCCESS (2.152s)
[368.282449] Starting dynamic subtest: vcs0
[370.229595] Dynamic subtest vcs0: SUCCESS (2.161s)
[370.270113] Starting dynamic subtest: vecs0
[372.554597] Dynamic subtest vecs0: SUCCESS (2.149s)
[372.575833] Subtest parallel: SUCCESS (8.626s)
[373.077526] [100/138] (639s left) kms_color (degamma)
[373.414538] Starting subtest: degamma
[373.432977] Starting dynamic subtest: pipe-A
[374.006109] Dynamic subtest pipe-A: SUCCESS (0.579s)
[374.053987] Starting dynamic subtest: pipe-B
[374.750800] Dynamic subtest pipe-B: SUCCESS (0.741s)
[374.793042] Starting dynamic subtest: pipe-C
[375.516426] Dynamic subtest pipe-C: SUCCESS (0.766s)
[375.538704] Subtest degamma: SUCCESS (2.094s)
[375.874560] [101/138] (637s left) kms_busy (extended-pageflip-hang-oldfb)
[376.199902] Starting subtest: extended-pageflip-hang-oldfb
[376.218305] Starting dynamic subtest: pipe-A
[376.719113] Dynamic subtest pipe-A: SUCCESS (0.531s)
[376.758990] Starting dynamic subtest: pipe-C
[377.203435] Dynamic subtest pipe-C: SUCCESS (0.474s)
[377.222041] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.019s)
[377.581941] [102/138] (635s left) gem_exec_reloc (basic-concurrent16)
[377.819259] Starting subtest: basic-concurrent16
[383.494356] Subtest basic-concurrent16: SUCCESS (5.458s)
[383.590934] [103/138] (629s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[383.946683] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[383.988960] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[384.081675] [104/138] (629s left) v3d/v3d_submit_csd (bad-perfmon)
[384.383754] Subtest bad-perfmon: SKIP (0.000s)
[384.494510] [105/138] (629s left) api_intel_bb (blit-reloc-keep-cache)
[384.757338] Starting subtest: blit-reloc-keep-cache
[384.780228] Subtest blit-reloc-keep-cache: SUCCESS (0.019s)
[384.890630] [106/138] (628s left) dmabuf_sync_file (export-wait-after-attach)
[385.131878] Starting subtest: export-wait-after-attach
[385.153125] Subtest export-wait-after-attach: SUCCESS (0.002s)
[385.246229] [107/138] (628s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[385.737854] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[385.780405] Subtest pipe-C-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.001s)
[386.120987] [108/138] (627s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[386.357145] Starting subtest: etime-multi-wait-all-for-submit-submitted
[386.440042] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[386.553953] [109/138] (627s left) gem_exec_suspend (basic-s0)
[386.792707] Starting subtest: basic-S0
[386.811736] Starting dynamic subtest: smem
[407.528942] Dynamic subtest smem: SUCCESS (20.735s)
[407.549516] Subtest basic-S0: SUCCESS (20.738s)
[413.927687] [110/138] (606s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[414.299778] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[414.342612] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[414.440404] [111/138] (605s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[414.738340] Starting subtest: fb-8bpc-vs-panel-8bpc
[414.757128] Starting dynamic subtest: pipe-A-DP-1
[415.147549] Dynamic subtest pipe-A-DP-1: SUCCESS (0.417s)
[415.166302] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.420s)
[415.490406] [112/138] (604s left) v3d/v3d_submit_cl (bad-multisync-extension)
[415.764650] Subtest bad-multisync-extension: SKIP (0.000s)
[415.855071] [113/138] (604s left) gem_ctx_persistence (engines-hang)
[416.099119] Starting subtest: engines-hang
[416.118185] Starting dynamic subtest: rcs0
[416.138390] Dynamic subtest rcs0: SUCCESS (0.035s)
[416.178681] Starting dynamic subtest: bcs0
[416.221491] Dynamic subtest bcs0: SKIP (0.005s)
[416.264364] Starting dynamic subtest: vcs0
[416.285178] Dynamic subtest vcs0: SUCCESS (0.060s)
[416.324544] Starting dynamic subtest: vecs0
[416.343298] Dynamic subtest vecs0: SUCCESS (0.035s)
[416.361735] Subtest engines-hang: SUCCESS (0.146s)
[416.457709] [114/138] (604s left) gem_userptr_blits (process-exit)
[416.779208] Starting subtest: process-exit
[416.798121] Subtest process-exit: SUCCESS (0.037s)
[416.923712] [115/138] (603s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[417.217348] Starting subtest: cursorB-vs-flipA-atomic-transitions
[417.258433] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.004s)
[417.350309] [116/138] (603s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-mtl-rc-ccs)
[417.776833] Starting subtest: pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs
[417.813527] Subtest pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[418.213063] [117/138] (602s left) i915_pm_rpm (gem-execbuf)
[420.000623] Starting subtest: gem-execbuf
[420.021303] Starting dynamic subtest: smem0
[421.538694] Dynamic subtest smem0: SUCCESS (1.534s)
[421.560307] Subtest gem-execbuf: SUCCESS (1.538s)
[422.046936] [118/138] (598s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[422.460810] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[422.498068] Subtest pipe-A-crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.001s)
[422.941513] [119/138] (597s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[423.477775] Subtest pipe-D-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[423.807371] [120/138] (597s left) kms_cursor_crc (cursor-offscreen-512x170)
[424.136464] Starting subtest: cursor-offscreen-512x170
[424.176111] Subtest cursor-offscreen-512x170: SKIP (0.003s)
[424.267463] [121/138] (596s left) kms_properties (plane-properties-legacy)
[424.595469] Starting subtest: plane-properties-legacy
[426.390501] Subtest plane-properties-legacy: SUCCESS (1.811s)
[426.750815] [122/138] (594s left) vc4/vc4_purgeable_bo (access-purged-bo-mem)
[427.038975] Subtest access-purged-bo-mem: SKIP (0.000s)
[427.128402] [123/138] (594s left) gem_tiled_partial_pwrite_pread (reads)
[427.363313] Starting subtest: reads
[428.755392] Subtest reads: SUCCESS (1.406s)
[428.899417] [124/138] (592s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[429.230756] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[448.901794] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (19.679s)
[449.238560] [125/138] (572s left) perf (low-oa-exponent-permissions)
[449.614563] Starting subtest: low-oa-exponent-permissions
[449.776380] Subtest low-oa-exponent-permissions: SUCCESS (0.154s)
[449.886837] [126/138] (571s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[450.253547] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[450.292309] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[450.382307] [127/138] (571s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[450.851104] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[450.888075] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[451.257545] [128/138] (570s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[451.494152] Starting subtest: yf-tiled-ccs-to-y-tiled
[451.512616] Starting dynamic subtest: smem
[451.804277] Dynamic subtest smem: SUCCESS (0.321s)
[451.825592] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.324s)
[452.040600] [129/138] (569s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[452.277629] Starting subtest: invalid-multi-wait-unsubmitted
[452.296443] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[452.387104] [130/138] (569s left) kms_chamelium_edid (hdmi-edid-read)
[452.803075] Subtest hdmi-edid-read: SKIP (0.000s)
[453.105544] [131/138] (568s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-mtl-rc-ccs)
[453.606865] Starting subtest: pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs
[453.676600] Subtest pipe-C-random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[453.991352] [132/138] (568s left) gem_readwrite (beyond-eob)
[454.220087] Starting subtest: beyond-EOB
[454.256902] Subtest beyond-EOB: SUCCESS (0.000s)
[454.355374] [133/138] (567s left) kms_pm_rpm (modeset-lpsp)
[456.131166] Starting subtest: modeset-lpsp
[456.624735] Subtest modeset-lpsp: SKIP (0.475s)
[457.112364] [134/138] (565s left) perf (invalid-oa-exponent)
[457.445079] Starting subtest: invalid-oa-exponent
[457.470778] Subtest invalid-oa-exponent: SUCCESS (0.061s)
[457.605542] [135/138] (564s left) gem_exec_params (no-blt)
[457.854724] Starting subtest: no-blt
[457.878961] Subtest no-blt: SUCCESS (0.003s)
[457.991579] [136/138] (564s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[458.375875] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[458.432636] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[458.548804] [137/138] (564s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[458.867232] Starting subtest: coverage-vs-premult-vs-constant
[459.182852] Starting dynamic subtest: pipe-A-DP-1
[459.622922] Dynamic subtest pipe-A-DP-1: SUCCESS (0.442s)
[459.664762] Starting dynamic subtest: pipe-C-DP-1
[460.274188] Dynamic subtest pipe-C-DP-1: SUCCESS (0.646s)
[460.294342] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.416s)
[460.669476] [138/138] (562s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[460.972744] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[460.991920] Starting dynamic subtest: pipe-A-valid-mode
[461.103126] Dynamic subtest pipe-A-valid-mode: SKIP (0.095s)
[461.140695] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.100s)
[461.372764] Closing watchdogs
Done.