[43.674886] Initializing watchdogs
[43.674966]   /dev/watchdog0
[43.681957] [001/137] (960s left) gem_ctx_persistence (engines-queued)
[43.758770] Starting subtest: engines-queued
[43.760369] Starting dynamic subtest: rcs0
[43.822816] Dynamic subtest rcs0: SUCCESS (0.064s)
[43.828118] Starting dynamic subtest: bcs0
[43.851895] Dynamic subtest bcs0: SUCCESS (0.029s)
[43.857013] Starting dynamic subtest: vcs0
[43.898965] Dynamic subtest vcs0: SUCCESS (0.047s)
[43.905039] Starting dynamic subtest: vcs1
[43.959311] Dynamic subtest vcs1: SUCCESS (0.060s)
[43.970076] Starting dynamic subtest: vecs0
[44.026852] Dynamic subtest vecs0: SUCCESS (0.067s)
[44.029104] Subtest engines-queued: SUCCESS (0.267s)
[44.162401] [002/137] (960s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[46.253291] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[48.212937] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SUCCESS (1.959s)
[48.635592] [003/137] (955s left) prime_vgem (fence-wait)
[48.745344] Starting subtest: fence-wait
[48.746845] Starting dynamic subtest: rcs0
[49.802651] Dynamic subtest rcs0: SUCCESS (1.053s)
[49.808255] Starting dynamic subtest: bcs0
[50.849157] Dynamic subtest bcs0: SUCCESS (1.047s)
[50.854414] Starting dynamic subtest: vcs0
[51.893447] Dynamic subtest vcs0: SUCCESS (1.042s)
[51.899364] Starting dynamic subtest: vcs1
[52.935934] Dynamic subtest vcs1: SUCCESS (1.042s)
[52.941286] Starting dynamic subtest: vecs0
[53.978428] Dynamic subtest vecs0: SUCCESS (1.042s)
[53.981365] Subtest fence-wait: SUCCESS (5.229s)
[54.094046] [004/137] (950s left) kms_atomic (plane-immutable-zpos)
[56.350910] Starting subtest: plane-immutable-zpos
[56.753462] Subtest plane-immutable-zpos: SUCCESS (0.402s)
[56.931604] [005/137] (947s left) kms_flip (nonexisting-fb-interruptible)
[57.958500] Starting subtest: nonexisting-fb-interruptible
[57.969330] Starting dynamic subtest: A-HDMI-A4
[58.182034] Dynamic subtest A-HDMI-A4: SUCCESS (0.213s)
[58.187691] Starting dynamic subtest: B-HDMI-A4
[58.301320] Dynamic subtest B-HDMI-A4: SUCCESS (0.119s)
[58.307177] Starting dynamic subtest: C-HDMI-A4
[58.440143] Dynamic subtest C-HDMI-A4: SUCCESS (0.138s)
[58.445871] Starting dynamic subtest: D-HDMI-A4
[58.560342] Dynamic subtest D-HDMI-A4: SUCCESS (0.120s)
[58.561622] Subtest nonexisting-fb-interruptible: SUCCESS (0.602s)
[58.697656] [006/137] (945s left) kms_vblank (pipe-d-accuracy-idle)
[60.665973] Starting subtest: pipe-D-accuracy-idle
[64.063207] Subtest pipe-D-accuracy-idle: SUCCESS (3.398s)
[64.161465] [007/137] (940s left) gem_userptr_blits (map-fixed-invalidate-busy)
[64.240034] Starting subtest: map-fixed-invalidate-busy
[64.243117] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[64.328350] [008/137] (939s left) kms_setmode (invalid-clone-single-crtc-stealing)
[64.393635] Starting subtest: invalid-clone-single-crtc-stealing
[64.399113] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[64.444571] [009/137] (939s left) i915_suspend (basic-s3-without-i915)
[64.516313] Starting subtest: basic-s3-without-i915
[88.548065] Subtest basic-s3-without-i915: SUCCESS (12.162s)
[92.552817] [010/137] (926s left) perf_pmu (all-busy-idle-check-all)
[92.629958] Starting subtest: all-busy-idle-check-all
[93.310290] Subtest all-busy-idle-check-all: SUCCESS (0.679s)
[93.400188] [011/137] (925s left) gem_ctx_shared (q-promotion)
[93.501597] Starting subtest: Q-promotion
[93.503042] Starting dynamic subtest: rcs0
[93.669962] Dynamic subtest rcs0: SUCCESS (0.165s)
[93.677003] Starting dynamic subtest: bcs0
[93.781973] Dynamic subtest bcs0: SUCCESS (0.114s)
[93.789038] Starting dynamic subtest: vcs0
[93.894090] Dynamic subtest vcs0: SUCCESS (0.110s)
[93.901188] Starting dynamic subtest: vcs1
[94.006216] Dynamic subtest vcs1: SUCCESS (0.112s)
[94.013240] Starting dynamic subtest: vecs0
[94.132063] Dynamic subtest vecs0: SUCCESS (0.125s)
[94.133763] Subtest Q-promotion: SUCCESS (0.627s)
[94.385362] [012/137] (924s left) i915_pm_backlight (fade)
[96.361302] Subtest fade: SKIP (0.000s)
[96.380576] [013/137] (922s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[98.584327] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[98.587490] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[98.817286] [014/137] (920s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[100.789051] Starting subtest: fbc-rgb101010-draw-mmap-wc
[103.634288] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.848s)
[103.733341] [015/137] (915s left) gem_exec_balancer (indices)
[103.810822] Starting subtest: indices
[105.050397] Subtest indices: SUCCESS (1.239s)
[105.349753] [016/137] (913s left) gem_userptr_blits (sync-unmap-after-close)
[105.432083] Starting subtest: sync-unmap-after-close
[105.447629] Subtest sync-unmap-after-close: SUCCESS (0.016s)
[105.577852] [017/137] (913s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-0-25)
[107.545994] Starting subtest: planes-downscale-factor-0-75-upscale-0-25
[107.547695] Starting dynamic subtest: pipe-A-HDMI-A-4
[107.715319] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.169s)
[107.722852] Starting dynamic subtest: pipe-B-HDMI-A-4
[107.871329] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.155s)
[107.878846] Starting dynamic subtest: pipe-C-HDMI-A-4
[108.027196] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.154s)
[108.034820] Starting dynamic subtest: pipe-D-HDMI-A-4
[108.182463] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.154s)
[108.184314] Subtest planes-downscale-factor-0-75-upscale-0-25: SUCCESS (0.637s)
[108.322419] [018/137] (911s left) kms_big_fb (linear-8bpp-rotate-90)
[110.307138] Starting subtest: linear-8bpp-rotate-90
[110.383345] Subtest linear-8bpp-rotate-90: SKIP (0.075s)
[110.472530] [019/137] (908s left) kms_properties (get_properties-sanity-atomic)
[112.440510] Starting subtest: get_properties-sanity-atomic
[112.447850] Subtest get_properties-sanity-atomic: SUCCESS (0.008s)
[112.503006] [020/137] (906s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[114.489001] Starting subtest: x-tiled-8bpp-rotate-90
[114.564085] Subtest x-tiled-8bpp-rotate-90: SKIP (0.074s)
[114.653432] [021/137] (904s left) sw_sync (sync_busy_fork)
[114.714967] Starting subtest: sync_busy_fork
[115.728545] Subtest sync_busy_fork: SUCCESS (1.014s)
[115.770143] [022/137] (903s left) gem_exec_schedule (u-semaphore-noskip)
[115.852572] Starting subtest: u-semaphore-noskip
[116.265776] Subtest u-semaphore-noskip: SUCCESS (0.410s)
[116.604681] [023/137] (902s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs)
[118.825318] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs
[118.828117] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[119.045669] [024/137] (900s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[121.192128] Starting subtest: cursor-rapid-movement-512x512
[121.195167] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[121.382670] [025/137] (898s left) kms_chamelium_frames (dp-frame-dump)
[123.421247] Subtest dp-frame-dump: SKIP (0.000s)
[123.478615] [026/137] (896s left) gem_exec_params (secure-non-master)
[123.543947] Starting subtest: secure-non-master
[123.545755] Subtest secure-non-master: SKIP (0.000s)
[123.632763] [027/137] (895s left) gem_mmap_gtt (medium-copy)
[123.696224] Subtest medium-copy: SKIP (0.000s)
[123.725858] [028/137] (895s left) gem_ctx_isolation (preservation-s3)
[123.793970] Starting subtest: preservation-S3
[123.794926] Starting dynamic subtest: rcs0
[145.312851] Dynamic subtest rcs0: SUCCESS (9.234s)
[145.320335] Starting dynamic subtest: bcs0
[166.328736] Dynamic subtest bcs0: SUCCESS (9.114s)
[166.336185] Starting dynamic subtest: vcs0
[187.339509] Dynamic subtest vcs0: SUCCESS (9.108s)
[187.346861] Starting dynamic subtest: vcs1
[208.309849] Dynamic subtest vcs1: SUCCESS (9.161s)
[208.317107] Starting dynamic subtest: vecs0
[229.315930] Dynamic subtest vecs0: SUCCESS (9.153s)
[229.316735] Subtest preservation-S3: SUCCESS (45.772s)
[236.543893] [029/137] (849s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[236.618010] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[236.618853] Starting dynamic subtest: smem
[236.704280] Dynamic subtest smem: SUCCESS (0.086s)
[236.711626] Starting dynamic subtest: lmem0
[237.812080] Dynamic subtest lmem0: SUCCESS (1.105s)
[237.812973] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (1.191s)
[238.023136] [030/137] (848s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[239.996987] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[239.999005] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[240.076398] [031/137] (846s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[242.067891] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[242.069912] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[242.142277] [032/137] (844s left) kms_vblank (pipe-a-query-forked)
[244.121343] Starting subtest: pipe-A-query-forked
[246.450347] Subtest pipe-A-query-forked: SUCCESS (2.328s)
[246.562812] [033/137] (839s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[248.532307] Starting subtest: primary-4-tiled-reflect-x-180
[248.630161] Subtest primary-4-tiled-reflect-x-180: SKIP (0.099s)
[248.710178] [034/137] (837s left) gem_create (create-ext-cpu-access-sanity-check)
[248.943312] Starting subtest: create-ext-cpu-access-sanity-check
[248.951708] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.013s)
[249.072118] [035/137] (837s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[251.045123] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[251.047198] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[251.128112] [036/137] (835s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs)
[253.164431] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs
[253.525850] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.362s)
[253.992861] [037/137] (832s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[256.281314] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[256.390681] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.109s)
[256.555451] [038/137] (829s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[258.521596] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[258.523571] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[258.605356] [039/137] (827s left) api_intel_bb (object-noreloc-purge-cache-simple)
[258.690623] Starting subtest: object-noreloc-purge-cache-simple
[258.704619] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.015s)
[258.774214] [040/137] (827s left) perf_pmu (busy-idle-no-semaphores)
[258.852133] Starting subtest: busy-idle-no-semaphores
[258.853079] Starting dynamic subtest: rcs0
[259.479964] Dynamic subtest rcs0: SUCCESS (0.623s)
[259.489458] Starting dynamic subtest: bcs0
[260.096153] Dynamic subtest bcs0: SUCCESS (0.614s)
[260.105130] Starting dynamic subtest: vcs0
[260.712205] Dynamic subtest vcs0: SUCCESS (0.614s)
[260.721257] Starting dynamic subtest: vcs1
[261.327261] Dynamic subtest vcs1: SUCCESS (0.613s)
[261.336154] Starting dynamic subtest: vecs0
[261.942284] Dynamic subtest vecs0: SUCCESS (0.613s)
[261.944526] Subtest busy-idle-no-semaphores: SUCCESS (3.086s)
[262.065435] [041/137] (824s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[264.030281] Starting subtest: 2x-flip-vs-cursor-legacy
[264.034562] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.003s)
[264.087592] [042/137] (822s left) drm_fdinfo (most-busy-idle-check-all)
[264.155821] Subtest most-busy-idle-check-all: SKIP (0.000s)
[264.180881] [043/137] (822s left) syncobj_timeline (invalid-signal-bad-pad)
[264.246417] Starting subtest: invalid-signal-bad-pad
[264.247420] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[264.306002] [044/137] (822s left) kms_pipe_crc_basic (suspend-read-crc)
[266.283428] Starting subtest: suspend-read-crc
[266.284484] Starting dynamic subtest: pipe-A-HDMI-A-4
[288.659375] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (9.938s)
[288.669722] Starting dynamic subtest: pipe-B-HDMI-A-4
[310.998092] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (10.252s)
[311.010940] Starting dynamic subtest: pipe-C-HDMI-A-4
[334.357561] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (10.977s)
[334.365300] Starting dynamic subtest: pipe-D-HDMI-A-4
[358.727144] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (11.716s)
[358.728100] Subtest suspend-read-crc: SUCCESS (42.891s)
[364.858743] [045/137] (777s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_mc_ccs)
[366.834013] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs
[366.835914] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[367.289316] [046/137] (774s left) gem_exec_whisper (basic-forked)
[367.361305] Starting subtest: basic-forked
[373.774724] Subtest basic-forked: SUCCESS (6.412s)
[373.962450] [047/137] (768s left) gem_mmap_gtt (basic-small-copy)
[374.029041] Subtest basic-small-copy: SKIP (0.000s)
[374.064386] [048/137] (768s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[374.133449] Subtest writes-after-reads: SKIP (0.000s)
[374.164232] [049/137] (768s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[374.230392] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[374.231160] Starting dynamic subtest: smem
[374.318610] Dynamic subtest smem: SUCCESS (0.088s)
[374.326065] Starting dynamic subtest: lmem0
[375.427107] Dynamic subtest lmem0: SUCCESS (1.105s)
[375.427932] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (1.193s)
[375.647025] [050/137] (766s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[377.616289] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[377.617367] Starting dynamic subtest: pipe-A-valid-mode
[378.630383] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.014s)
[378.631331] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.016s)
[378.756317] [051/137] (763s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[380.725111] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[380.726218] Starting dynamic subtest: pipe-A-valid-mode
[381.418176] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.693s)
[381.424123] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.694s)
[381.556133] [052/137] (760s left) gem_pxp (hw-rejects-pxp-context)
[384.138123] Starting subtest: hw-rejects-pxp-context
[384.139066] Subtest hw-rejects-pxp-context: SUCCESS (0.003s)
[384.224326] [053/137] (758s left) kms_concurrent (pipe-a)
[386.192358] Starting subtest: pipe-A
[386.193454] Starting dynamic subtest: HDMI-A-4
[386.523452] Dynamic subtest HDMI-A-4: SUCCESS (0.330s)
[386.526875] Subtest pipe-A: SUCCESS (0.332s)
[386.677950] [054/137] (755s left) v3d/v3d_submit_csd (single-in-sync)
[386.778038] Subtest single-in-sync: SKIP (0.000s)
[386.827614] [055/137] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[388.800690] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[388.802967] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[388.877043] [056/137] (753s left) gem_eio (in-flight-immediate)
[389.109045] Starting subtest: in-flight-immediate
[393.389860] Subtest in-flight-immediate: SUCCESS (4.281s)
[395.469374] [057/137] (746s left) gem_exec_balancer (bonded-dual)
[395.537375] Subtest bonded-dual: SKIP (0.000s)
[395.876037] [058/137] (746s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[398.159176] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[398.505738] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SUCCESS (0.347s)
[398.729705] [059/137] (743s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[399.752136] Starting subtest: 2x-plain-flip-ts-check-interruptible
[399.778261] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.025s)
[399.846062] [060/137] (742s left) kms_addfb_basic (addfb25-modifier-no-flag)
[401.842232] Starting subtest: addfb25-modifier-no-flag
[401.843339] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[405.727517] [061/137] (736s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[407.716726] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[407.718732] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[407.794274] [062/137] (734s left) i915_pm_rpm (debugfs-forcewake-user)
[412.161137] Starting subtest: debugfs-forcewake-user
[424.911048] Subtest debugfs-forcewake-user: SUCCESS (12.754s)
[426.058095] [063/137] (716s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[428.139722] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[428.140845] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[428.484508] [064/137] (713s left) kms_vblank (pipe-b-ts-continuation-dpms-suspend)
[430.449850] Starting subtest: pipe-B-ts-continuation-dpms-suspend
[452.191998] Subtest pipe-B-ts-continuation-dpms-suspend: SUCCESS (9.515s)
[458.317451] [065/137] (702s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[460.284494] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[460.286762] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[460.368529] [066/137] (700s left) v3d/v3d_submit_cl (bad-extension)
[460.501802] Subtest bad-extension: SKIP (0.000s)
[460.554393] [067/137] (700s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[462.537798] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[462.539763] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[462.617744] [068/137] (698s left) i915_hangman (engine-engine-error)
[462.703849] Starting subtest: engine-engine-error
[462.704760] Starting dynamic subtest: rcs0
[463.397627] Dynamic subtest rcs0: SUCCESS (0.693s)
[463.406177] Starting dynamic subtest: bcs0
[464.045139] Dynamic subtest bcs0: SUCCESS (0.647s)
[464.053655] Starting dynamic subtest: vcs0
[464.690560] Dynamic subtest vcs0: SUCCESS (0.645s)
[464.699161] Starting dynamic subtest: vcs1
[465.345535] Dynamic subtest vcs1: SUCCESS (0.654s)
[465.354688] Starting dynamic subtest: vecs0
[465.987254] Dynamic subtest vecs0: SUCCESS (0.641s)
[465.988216] Subtest engine-engine-error: SUCCESS (3.283s)
[466.109703] [069/137] (694s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[466.171198] Starting subtest: multi-wait-for-submit-submitted-signaled
[466.172151] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[466.244554] [070/137] (694s left) gem_userptr_blits (unsync-unmap-cycles)
[466.341426] Subtest unsync-unmap-cycles: SKIP (0.000s)
[466.500805] [071/137] (694s left) kms_plane_scaling (i915-max-src-size)
[468.487181] Starting subtest: i915-max-src-size
[468.488209] Starting dynamic subtest: pipe-A-HDMI-A-4
[468.988216] Dynamic subtest pipe-A-HDMI-A-4: FAIL (0.091s)
[468.989528] Subtest i915-max-src-size: FAIL (0.434s)
[469.071812] [072/137] (691s left) gem_mmap_gtt (cpuset-big-copy-odd)
[469.148226] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[469.176479] [073/137] (691s left) gem_exec_fence (basic-busy)
[469.399012] Starting subtest: basic-busy
[469.400621] Starting dynamic subtest: rcs0
[469.465217] Dynamic subtest rcs0: SUCCESS (0.067s)
[469.477104] Starting dynamic subtest: bcs0
[469.515872] Dynamic subtest bcs0: SUCCESS (0.049s)
[469.553150] Starting dynamic subtest: vcs0
[469.578296] Dynamic subtest vcs0: SUCCESS (0.060s)
[469.592668] Starting dynamic subtest: vcs1
[469.632871] Dynamic subtest vcs1: SUCCESS (0.053s)
[469.661425] Starting dynamic subtest: vecs0
[469.689566] Dynamic subtest vecs0: SUCCESS (0.055s)
[469.691006] Subtest basic-busy: SUCCESS (0.294s)
[470.220058] [074/137] (690s left) v3d/v3d_submit_csd (bad-multisync-in-sync)
[470.299660] Subtest bad-multisync-in-sync: SKIP (0.000s)
[470.352640] [075/137] (690s left) kms_atomic (plane-cursor-legacy)
[472.537874] Starting subtest: plane-cursor-legacy
[472.604266] Subtest plane-cursor-legacy: SUCCESS (0.066s)
[472.785618] [076/137] (688s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[474.795998] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[474.853639] [077/137] (686s left) gem_softpin (evict-active-interruptible)
[474.920119] Starting subtest: evict-active-interruptible
[474.929875] Subtest evict-active-interruptible: SUCCESS (0.010s)
[475.024177] [078/137] (685s left) i915_pm_rpm (gem-idle)
[479.471115] Starting subtest: gem-idle
[487.022033] Subtest gem-idle: SUCCESS (7.552s)
[488.098005] [079/137] (672s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[489.128278] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[489.153858] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.025s)
[489.213822] [080/137] (671s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[491.210354] Starting subtest: fbcpsr-indfb-scaledprimary
[491.214928] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[491.297606] [081/137] (669s left) gem_exec_schedule (preempt-queue-contexts-chain)
[491.396519] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[491.739139] [082/137] (669s left) gem_mmap_wc (write-gtt-read-wc)
[491.800758] Subtest write-gtt-read-wc: SKIP (0.000s)
[491.823224] [083/137] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[493.791445] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[493.793605] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[493.880449] [084/137] (667s left) dmabuf (all-tests)
[493.964731] Starting subtest: all-tests
[493.965962] Starting dynamic subtest: sanitycheck
[493.988777] Dynamic subtest sanitycheck: SUCCESS (0.023s)
[493.998215] Starting dynamic subtest: dma_fence
[494.123650] Dynamic subtest dma_fence: SUCCESS (0.134s)
[494.132716] Starting dynamic subtest: dma_fence_chain
[507.128636] Dynamic subtest dma_fence_chain: SUCCESS (13.001s)
[507.137226] Starting dynamic subtest: dma_fence_unwrap
[507.158622] Dynamic subtest dma_fence_unwrap: SUCCESS (0.032s)
[507.167830] Starting dynamic subtest: dma_resv
[507.192663] Dynamic subtest dma_resv: SUCCESS (0.033s)
[507.193724] Subtest all-tests: SUCCESS (13.228s)
[507.295112] [085/137] (653s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[509.269098] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[540.003295] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.735s)
[540.124083] [086/137] (621s left) dumb_buffer (create-clear)
[540.186550] Starting subtest: create-clear
[577.781500] Subtest create-clear: SUCCESS (37.592s)
[577.884510] [087/137] (583s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted)
[577.945966] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted
[577.946788] Subtest invalid-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.000s)
[578.007989] [088/137] (583s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[579.986578] Starting subtest: fbc-1p-pri-indfb-multidraw
[592.250627] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.266s)
[592.388415] [089/137] (568s left) gem_lmem_swapping (massive)
[595.913089] Starting subtest: massive
[595.913924] Starting dynamic subtest: lmem0
[608.280467] Dynamic subtest lmem0: SUCCESS (12.363s)
[608.281432] Subtest massive: SUCCESS (12.364s)
[611.910169] [090/137] (549s left) gem_render_copy (y-tiled-ccs-to-linear)
[614.342897] Starting subtest: y-tiled-ccs-to-linear
[614.343662] Starting dynamic subtest: smem
[614.431031] Dynamic subtest smem: SUCCESS (0.087s)
[614.438014] Starting dynamic subtest: lmem0
[614.730592] Dynamic subtest lmem0: SUCCESS (0.299s)
[614.731447] Subtest y-tiled-ccs-to-linear: SUCCESS (0.388s)
[615.304198] [091/137] (545s left) kms_vblank (pipe-a-query-forked-hang)
[617.276971] Starting subtest: pipe-A-query-forked-hang
[630.742521] Subtest pipe-A-query-forked-hang: SUCCESS (13.467s)
[630.843666] [092/137] (530s left) gem_userptr_blits (process-exit)
[630.917722] Starting subtest: process-exit
[630.927171] Subtest process-exit: SUCCESS (0.009s)
[631.034808] [093/137] (530s left) gem_fenced_exec_thrash (too-many-fences)
[631.099965] Subtest too-many-fences: SKIP (0.000s)
[631.119817] [094/137] (530s left) drm_read (empty-block)
[633.160154] Starting subtest: empty-block
[634.163562] Subtest empty-block: SUCCESS (1.000s)
[634.291430] [095/137] (527s left) syncobj_wait (invalid-wait-illegal-handle)
[634.353281] Starting subtest: invalid-wait-illegal-handle
[634.354280] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[634.409002] [096/137] (526s left) gem_vm_create (isolation)
[634.476771] Starting subtest: isolation
[634.484844] Subtest isolation: SUCCESS (0.008s)
[634.621432] [097/137] (526s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[636.621116] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[636.623368] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[636.692460] [098/137] (524s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[638.673481] Starting subtest: basic-busy-flip-before-cursor-varying-size
[638.675485] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[638.725363] [099/137] (522s left) kms_psr (primary_mmap_cpu)
[638.789839] Subtest primary_mmap_cpu: SKIP (0.000s)
[638.819444] [100/137] (522s left) vc4/vc4_wait_bo (used-bo-1ns)
[638.926427] Subtest used-bo-1ns: SKIP (0.000s)
[638.978146] [101/137] (522s left) kms_psr2_su (page_flip-p010)
[639.050558] Subtest page_flip-P010: SKIP (0.000s)
[639.085600] [102/137] (522s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[641.056155] Starting subtest: psr-2p-primscrn-cur-indfb-move
[641.058358] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[641.125465] [103/137] (520s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[643.117840] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[643.119842] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[643.191435] [104/137] (518s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[645.182463] Starting subtest: primary-yf-tiled-reflect-x-180
[645.275829] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.094s)
[645.356845] [105/137] (516s left) gem_tiled_blits (interruptible)
[645.457931] Subtest interruptible: SKIP (0.000s)
[645.484216] [106/137] (516s left) vc4/vc4_mmap (mmap-bo)
[645.575680] Subtest mmap-bo: SKIP (0.000s)
[645.624933] [107/137] (515s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[647.744316] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[647.746219] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[648.071199] [108/137] (513s left) kms_getfb (getfb2-into-addfb2)
[648.133890] Starting subtest: getfb2-into-addfb2
[648.134854] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[648.197784] [109/137] (513s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[650.174581] Starting subtest: y-tiled-32bpp-rotate-270
[651.908302] Subtest y-tiled-32bpp-rotate-270: SUCCESS (1.730s)
[652.065641] [110/137] (509s left) kms_flip (dpms-off-confusion-interruptible)
[653.116902] Starting subtest: dpms-off-confusion-interruptible
[653.128667] Starting dynamic subtest: A-HDMI-A4
[660.865015] Dynamic subtest A-HDMI-A4: SUCCESS (7.736s)
[660.877437] Starting dynamic subtest: B-HDMI-A4
[668.543703] Dynamic subtest B-HDMI-A4: SUCCESS (7.676s)
[668.554451] Starting dynamic subtest: C-HDMI-A4
[676.212457] Dynamic subtest C-HDMI-A4: SUCCESS (7.666s)
[676.220312] Starting dynamic subtest: D-HDMI-A4
[683.879901] Dynamic subtest D-HDMI-A4: SUCCESS (7.665s)
[683.882182] Subtest dpms-off-confusion-interruptible: SUCCESS (30.762s)
[684.000903] [111/137] (477s left) kms_cursor_crc (cursor-offscreen-512x170)
[686.160284] Starting subtest: cursor-offscreen-512x170
[686.163641] Subtest cursor-offscreen-512x170: SKIP (0.002s)
[686.353508] [112/137] (475s left) gem_ctx_param (set-priority-range)
[686.433202] Starting subtest: set-priority-range
[686.450483] Subtest set-priority-range: SUCCESS (0.018s)
[686.522034] [113/137] (475s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[688.496870] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[688.497857] Starting dynamic subtest: pipe-A-HDMI-A-4
[688.665867] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.168s)
[688.674116] Starting dynamic subtest: pipe-B-HDMI-A-4
[688.820875] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.153s)
[688.828973] Starting dynamic subtest: pipe-C-HDMI-A-4
[688.976237] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.153s)
[688.984837] Starting dynamic subtest: pipe-D-HDMI-A-4
[689.131096] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.153s)
[689.131975] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.636s)
[689.270744] [114/137] (472s left) kms_vblank (pipe-c-ts-continuation-modeset-rpm)
[691.238900] Starting subtest: pipe-C-ts-continuation-modeset-rpm
[694.433093] Subtest pipe-C-ts-continuation-modeset-rpm: SUCCESS (3.195s)
[695.602904] [115/137] (466s left) syncobj_timeline (single-wait-all-signaled)
[695.665097] Starting subtest: single-wait-all-signaled
[695.666005] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[695.718915] [116/137] (465s left) kms_content_protection (dp-mst-lic-type-1)
[697.724280] Starting subtest: dp-mst-lic-type-1
[697.726234] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[697.827077] [117/137] (463s left) perf_pmu (idle-no-semaphores)
[697.957696] Starting subtest: idle-no-semaphores
[697.958642] Starting dynamic subtest: rcs0
[698.478570] Dynamic subtest rcs0: SUCCESS (0.516s)
[698.486113] Starting dynamic subtest: bcs0
[698.984281] Dynamic subtest bcs0: SUCCESS (0.503s)
[698.991834] Starting dynamic subtest: vcs0
[699.490446] Dynamic subtest vcs0: SUCCESS (0.503s)
[699.498112] Starting dynamic subtest: vcs1
[699.996245] Dynamic subtest vcs1: SUCCESS (0.503s)
[700.003796] Starting dynamic subtest: vecs0
[700.502343] Dynamic subtest vecs0: SUCCESS (0.503s)
[700.503376] Subtest idle-no-semaphores: SUCCESS (2.540s)
[700.600710] [118/137] (461s left) perf (blocking-parameterized)
[700.733871] Starting subtest: blocking-parameterized
[720.775977] Subtest blocking-parameterized: SUCCESS (20.040s)
[720.798049] [119/137] (440s left) gem_exec_params (invalid-fence-in-submit)
[720.862223] Starting subtest: invalid-fence-in-submit
[720.867373] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[720.957376] [120/137] (440s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[722.970544] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[722.972571] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[723.049969] [121/137] (438s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_mc_ccs)
[725.234696] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs
[725.236595] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[725.496296] [122/137] (436s left) kms_lease (lease_get)
[727.463242] Starting subtest: lease_get
[727.466764] Starting dynamic subtest: pipe-A-HDMI-A-4
[727.467881] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[727.476312] Starting dynamic subtest: pipe-B-HDMI-A-4
[727.477502] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[727.485375] Starting dynamic subtest: pipe-C-HDMI-A-4
[727.486444] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[727.494114] Starting dynamic subtest: pipe-D-HDMI-A-4
[727.495248] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[727.496364] Subtest lease_get: SUCCESS (0.011s)
[727.529560] [123/137] (434s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[729.496063] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[729.498980] Starting dynamic subtest: pipe-A-valid-mode
[729.538494] Dynamic subtest pipe-A-valid-mode: SKIP (0.038s)
[729.540411] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.040s)
[729.625850] [124/137] (432s left) gem_exec_params (rsvd2-dirt)
[729.690191] Starting subtest: rsvd2-dirt
[729.692157] Subtest rsvd2-dirt: SKIP (0.000s)
[729.775815] [125/137] (432s left) syncobj_wait (wait-any-snapshot)
[729.836671] Starting subtest: wait-any-snapshot
[729.918307] Subtest wait-any-snapshot: SUCCESS (0.081s)
[730.021988] [126/137] (431s left) gem_mmap_wc (write-wc-read-gtt)
[730.108220] Subtest write-wc-read-gtt: SKIP (0.000s)
[730.134626] [127/137] (431s left) kms_cursor_crc (cursor-sliding-256x256)
[732.241218] Starting subtest: cursor-sliding-256x256
[732.248509] Starting dynamic subtest: pipe-A-HDMI-A-4
[736.681141] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.433s)
[736.708081] Starting dynamic subtest: pipe-B-HDMI-A-4
[741.270763] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (4.571s)
[741.296547] Starting dynamic subtest: pipe-C-HDMI-A-4
[746.357237] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (5.069s)
[746.383289] Starting dynamic subtest: pipe-D-HDMI-A-4
[751.691379] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (5.313s)
[751.692532] Subtest cursor-sliding-256x256: SUCCESS (19.448s)
[751.950291] [128/137] (410s left) gem_readwrite (new-obj)
[752.015107] Subtest new-obj: SKIP (0.000s)
[752.058613] [129/137] (409s left) gem_exec_fence (syncobj-export)
[752.469970] Starting subtest: syncobj-export
[752.484209] Subtest syncobj-export: SUCCESS (0.014s)
[752.878086] [130/137] (409s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[754.854806] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[754.856862] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[754.930798] [131/137] (407s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs)
[757.210204] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs
[757.211966] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[757.376440] [132/137] (404s left) kms_addfb_basic (unused-modifier)
[757.438891] Starting subtest: unused-modifier
[757.439845] Subtest unused-modifier: SUCCESS (0.000s)
[763.225758] [133/137] (398s left) gem_spin_batch (legacy-resubmit)
[763.313884] Starting subtest: legacy-resubmit
[763.314834] Starting dynamic subtest: default
[763.328055] Dynamic subtest default: SUCCESS (0.013s)
[763.336295] Starting dynamic subtest: render
[763.337244] Dynamic subtest render: SUCCESS (0.001s)
[763.345101] Starting dynamic subtest: bsd
[763.346249] Dynamic subtest bsd: SUCCESS (0.002s)
[763.353821] Starting dynamic subtest: bsd1
[763.355034] Dynamic subtest bsd1: SUCCESS (0.001s)
[763.362846] Starting dynamic subtest: bsd2
[763.364057] Dynamic subtest bsd2: SUCCESS (0.002s)
[763.371819] Starting dynamic subtest: blt
[763.373159] Dynamic subtest blt: SUCCESS (0.001s)
[763.380671] Starting dynamic subtest: vebox
[763.381809] Dynamic subtest vebox: SUCCESS (0.002s)
[763.382903] Subtest legacy-resubmit: SUCCESS (0.028s)
[763.590654] [134/137] (398s left) sysfs_preempt_timeout (idempotent)
[763.685759] Starting subtest: idempotent
[763.686755] Starting dynamic subtest: vecs0
[763.687690] Dynamic subtest vecs0: SUCCESS (0.000s)
[763.695774] Starting dynamic subtest: vcs0
[763.696931] Dynamic subtest vcs0: SUCCESS (0.001s)
[763.704588] Starting dynamic subtest: bcs0
[763.705843] Dynamic subtest bcs0: SUCCESS (0.001s)
[763.713248] Starting dynamic subtest: rcs0
[763.714317] Dynamic subtest rcs0: SUCCESS (0.001s)
[763.721730] Starting dynamic subtest: vcs1
[763.723001] Dynamic subtest vcs1: SUCCESS (0.000s)
[763.724111] Subtest idempotent: SUCCESS (0.006s)
[763.759549] [135/137] (398s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[765.760476] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[766.274430] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.514s)
[766.392807] [136/137] (395s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[766.461005] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[766.519032] [137/137] (395s left) sw_sync (sync_multi_timeline_wait)
[766.580758] Starting subtest: sync_multi_timeline_wait
[766.581678] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[766.623079] Closing watchdogs
Done.