[45.870333] Initializing watchdogs
[45.870399]   /dev/watchdog0
[45.876340] [001/141] (960s left) kms_universal_plane (universal-plane-pipe-c-sanity)
[46.014965] Starting subtest: universal-plane-pipe-C-sanity
[46.763783] Subtest universal-plane-pipe-C-sanity: SUCCESS (0.749s)
[46.964186] [002/141] (959s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[47.110863] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[47.111729] Starting dynamic subtest: pipe-A-valid-mode
[49.257654] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.146s)
[49.258808] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.147s)
[49.422630] [003/141] (956s left) gem_exec_fence (basic-busy)
[49.614526] Starting subtest: basic-busy
[49.615570] Starting dynamic subtest: rcs0
[49.709060] Dynamic subtest rcs0: SUCCESS (0.102s)
[49.730491] Starting dynamic subtest: bcs0
[49.762274] Dynamic subtest bcs0: SUCCESS (0.053s)
[49.785663] Starting dynamic subtest: vcs0
[49.817367] Dynamic subtest vcs0: SUCCESS (0.054s)
[49.838639] Starting dynamic subtest: vcs1
[49.877378] Dynamic subtest vcs1: SUCCESS (0.059s)
[49.896642] Starting dynamic subtest: vecs0
[49.934107] Dynamic subtest vecs0: SUCCESS (0.057s)
[49.953652] Starting dynamic subtest: vecs1
[49.991208] Dynamic subtest vecs1: SUCCESS (0.057s)
[50.010385] Starting dynamic subtest: ccs0
[50.044353] Dynamic subtest ccs0: SUCCESS (0.053s)
[50.065690] Starting dynamic subtest: ccs1
[50.099470] Dynamic subtest ccs1: SUCCESS (0.054s)
[50.121087] Starting dynamic subtest: ccs2
[50.159875] Dynamic subtest ccs2: SUCCESS (0.060s)
[50.181201] Starting dynamic subtest: ccs3
[50.217582] Dynamic subtest ccs3: SUCCESS (0.058s)
[50.219684] Subtest basic-busy: SUCCESS (0.611s)
[51.249924] [004/141] (955s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[51.390510] Starting subtest: x-tiled-64bpp-rotate-270
[51.444491] Subtest x-tiled-64bpp-rotate-270: SKIP (0.053s)
[51.539451] [005/141] (954s left) gem_eio (in-flight-contexts-immediate)
[51.804634] Starting subtest: in-flight-contexts-immediate
[65.461858] Subtest in-flight-contexts-immediate: SUCCESS (13.657s)
[65.590251] [006/141] (940s left) gem_exec_reloc (basic-gtt-cpu)
[65.658152] Subtest basic-gtt-cpu: SKIP (0.000s)
[65.701659] [007/141] (940s left) syncobj_basic (bad-destroy)
[65.777064] Starting subtest: bad-destroy
[65.778190] Subtest bad-destroy: SUCCESS (0.000s)
[65.843677] [008/141] (940s left) gem_exec_flush (basic-wb-rw-before-default)
[65.922318] Subtest basic-wb-rw-before-default: SKIP (0.000s)
[65.950661] [009/141] (940s left) kms_big_fb (yf-tiled-addfb)
[66.087119] Starting subtest: yf-tiled-addfb
[66.088831] Subtest yf-tiled-addfb: SKIP (0.000s)
[66.177168] [010/141] (940s left) perf_pmu (busy-idle)
[66.241061] Starting subtest: busy-idle
[66.241926] Starting dynamic subtest: rcs0
[66.948976] Dynamic subtest rcs0: SUCCESS (0.707s)
[66.958978] Starting dynamic subtest: bcs0
[67.612111] Dynamic subtest bcs0: SUCCESS (0.663s)
[67.621836] Starting dynamic subtest: vcs0
[68.269964] Dynamic subtest vcs0: SUCCESS (0.657s)
[68.279844] Starting dynamic subtest: vcs1
[68.934235] Dynamic subtest vcs1: SUCCESS (0.663s)
[68.944043] Starting dynamic subtest: vecs0
[69.598104] Dynamic subtest vecs0: SUCCESS (0.664s)
[69.607759] Starting dynamic subtest: vecs1
[70.263169] Dynamic subtest vecs1: SUCCESS (0.664s)
[70.272856] Starting dynamic subtest: ccs0
[70.926223] Dynamic subtest ccs0: SUCCESS (0.662s)
[70.935897] Starting dynamic subtest: ccs1
[71.590209] Dynamic subtest ccs1: SUCCESS (0.664s)
[71.600088] Starting dynamic subtest: ccs2
[72.260176] Dynamic subtest ccs2: SUCCESS (0.669s)
[72.270210] Starting dynamic subtest: ccs3
[72.923108] Dynamic subtest ccs3: SUCCESS (0.662s)
[72.925325] Subtest busy-idle: SUCCESS (6.681s)
[73.006291] [011/141] (933s left) kms_addfb_basic (size-max)
[73.140216] Starting subtest: size-max
[73.141198] Subtest size-max: SUCCESS (0.000s)
[73.223971] [012/141] (933s left) kms_flip (modeset-vs-vblank-race-interruptible)
[73.346883] Starting subtest: modeset-vs-vblank-race-interruptible
[73.351079] Starting dynamic subtest: A-DP2
[76.564304] Dynamic subtest A-DP2: SUCCESS (3.213s)
[76.570275] Starting dynamic subtest: B-DP2
[79.732949] Dynamic subtest B-DP2: SUCCESS (3.168s)
[79.738728] Starting dynamic subtest: C-DP2
[82.894784] Dynamic subtest C-DP2: SUCCESS (3.161s)
[82.900606] Starting dynamic subtest: D-DP2
[86.067061] Dynamic subtest D-DP2: SUCCESS (3.172s)
[86.069633] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.723s)
[86.286859] [013/141] (920s left) gem_mmap_wc (read-write)
[86.352788] Subtest read-write: SKIP (0.000s)
[86.380589] [014/141] (920s left) gem_request_retire (retire-vma-not-inactive)
[86.443956] Starting subtest: retire-vma-not-inactive
[86.516999] Subtest retire-vma-not-inactive: SUCCESS (0.073s)
[86.618901] [015/141] (919s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[86.753531] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[86.755212] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[86.852548] [016/141] (919s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area)
[86.914061] Subtest overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[86.929871] [017/141] (919s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[87.204190] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[87.589531] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SUCCESS (0.385s)
[87.888419] [018/141] (918s left) gen9_exec_parse (unaligned-jump)
[87.952881] Subtest unaligned-jump: SKIP (0.000s)
[87.982262] [019/141] (918s left) kms_ccs (pipe-d-bad-rotation-90-yf_tiled_ccs)
[88.300519] Starting subtest: pipe-D-bad-rotation-90-yf_tiled_ccs
[88.302573] Subtest pipe-D-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[88.466572] [020/141] (918s left) gem_exec_reloc (basic-write-read-active)
[88.530335] Subtest basic-write-read-active: SKIP (0.000s)
[88.561172] [021/141] (918s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[88.789406] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[88.792153] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[89.043129] [022/141] (917s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[89.175613] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[89.177648] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[89.226520] [023/141] (917s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[89.364973] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[89.366916] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[89.443449] [024/141] (917s left) kms_psr (primary_render)
[89.504043] Subtest primary_render: SKIP (0.000s)
[89.520208] [025/141] (917s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[89.656474] Starting subtest: psr-farfromfence-mmap-gtt
[89.658345] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[89.742906] [026/141] (916s left) i915_suspend (basic-s3-without-i915)
[89.801184] Starting subtest: basic-s3-without-i915
[111.356076] Subtest basic-s3-without-i915: SUCCESS (5.589s)
[114.529532] [027/141] (911s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[114.596219] Starting subtest: multi-wait-all-for-submit-available-submitted
[114.597135] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[114.653669] [028/141] (911s left) kms_busy (extended-pageflip-hang-newfb)
[114.793526] Starting subtest: extended-pageflip-hang-newfb
[114.794511] Starting dynamic subtest: pipe-A
[122.646964] Dynamic subtest pipe-A: SUCCESS (7.852s)
[122.654989] Starting dynamic subtest: pipe-D
[130.502232] Dynamic subtest pipe-D: SUCCESS (7.852s)
[130.503124] Subtest extended-pageflip-hang-newfb: SUCCESS (15.709s)
[130.679809] [029/141] (895s left) gem_ctx_shared (exec-shared-gtt)
[130.750139] Starting subtest: exec-shared-gtt
[130.751121] Starting dynamic subtest: rcs0
[130.758310] Dynamic subtest rcs0: SUCCESS (0.008s)
[130.765295] Starting dynamic subtest: bcs0
[130.766164] Dynamic subtest bcs0: SUCCESS (0.004s)
[130.773278] Starting dynamic subtest: vcs0
[130.774179] Dynamic subtest vcs0: SUCCESS (0.004s)
[130.781251] Starting dynamic subtest: vcs1
[130.782116] Dynamic subtest vcs1: SUCCESS (0.004s)
[130.789258] Starting dynamic subtest: vecs0
[130.790119] Dynamic subtest vecs0: SUCCESS (0.004s)
[130.796843] Starting dynamic subtest: vecs1
[130.797715] Dynamic subtest vecs1: SUCCESS (0.004s)
[130.804374] Starting dynamic subtest: ccs0
[130.805216] Dynamic subtest ccs0: SUCCESS (0.006s)
[130.812611] Starting dynamic subtest: ccs1
[130.813526] Dynamic subtest ccs1: SUCCESS (0.004s)
[130.820165] Starting dynamic subtest: ccs2
[130.821098] Dynamic subtest ccs2: SUCCESS (0.004s)
[130.827601] Starting dynamic subtest: ccs3
[130.828553] Dynamic subtest ccs3: SUCCESS (0.005s)
[130.829463] Subtest exec-shared-gtt: SUCCESS (0.056s)
[131.021589] [030/141] (894s left) gem_ctx_isolation (clean)
[131.114066] Starting subtest: clean
[131.115017] Starting dynamic subtest: rcs0
[131.189140] Dynamic subtest rcs0: SUCCESS (0.075s)
[131.196417] Starting dynamic subtest: bcs0
[131.267068] Dynamic subtest bcs0: SUCCESS (0.077s)
[131.274234] Starting dynamic subtest: vcs0
[131.363895] Dynamic subtest vcs0: SUCCESS (0.096s)
[131.371047] Starting dynamic subtest: vcs1
[131.450639] Dynamic subtest vcs1: SUCCESS (0.086s)
[131.457823] Starting dynamic subtest: vecs0
[131.552162] Dynamic subtest vecs0: SUCCESS (0.101s)
[131.559127] Starting dynamic subtest: vecs1
[131.634142] Dynamic subtest vecs1: SUCCESS (0.081s)
[131.641027] Starting dynamic subtest: ccs0
[131.722043] Dynamic subtest ccs0: SUCCESS (0.087s)
[131.728948] Starting dynamic subtest: ccs1
[131.805052] Dynamic subtest ccs1: SUCCESS (0.082s)
[131.812036] Starting dynamic subtest: ccs2
[131.875795] Dynamic subtest ccs2: SUCCESS (0.070s)
[131.882739] Starting dynamic subtest: ccs3
[131.963791] Dynamic subtest ccs3: SUCCESS (0.087s)
[131.964748] Subtest clean: SUCCESS (0.850s)
[132.169500] [031/141] (893s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[132.310279] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[133.181076] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.871s)
[133.297960] [032/141] (892s left) kms_plane_cursor (viewport)
[133.444950] Starting subtest: viewport
[133.446854] Starting dynamic subtest: pipe-A-DP-2-size-64
[136.497770] Dynamic subtest pipe-A-DP-2-size-64: SUCCESS (3.053s)
[136.570900] Starting dynamic subtest: pipe-A-DP-2-size-128
[139.564540] Dynamic subtest pipe-A-DP-2-size-128: SUCCESS (3.000s)
[139.637518] Starting dynamic subtest: pipe-A-DP-2-size-256
[142.631267] Dynamic subtest pipe-A-DP-2-size-256: SUCCESS (3.000s)
[142.762432] Starting dynamic subtest: pipe-B-DP-2-size-64
[145.894160] Dynamic subtest pipe-B-DP-2-size-64: SUCCESS (3.138s)
[145.950854] Starting dynamic subtest: pipe-B-DP-2-size-128
[149.060828] Dynamic subtest pipe-B-DP-2-size-128: SUCCESS (3.116s)
[149.117497] Starting dynamic subtest: pipe-B-DP-2-size-256
[152.161072] Dynamic subtest pipe-B-DP-2-size-256: SUCCESS (3.050s)
[152.275405] Starting dynamic subtest: pipe-C-DP-2-size-64
[155.306579] Dynamic subtest pipe-C-DP-2-size-64: SUCCESS (3.037s)
[155.362492] Starting dynamic subtest: pipe-C-DP-2-size-128
[158.323129] Dynamic subtest pipe-C-DP-2-size-128: SUCCESS (2.967s)
[158.379864] Starting dynamic subtest: pipe-C-DP-2-size-256
[161.306791] Dynamic subtest pipe-C-DP-2-size-256: SUCCESS (2.933s)
[161.422196] Starting dynamic subtest: pipe-D-DP-2-size-64
[164.521192] Dynamic subtest pipe-D-DP-2-size-64: SUCCESS (3.106s)
[164.577882] Starting dynamic subtest: pipe-D-DP-2-size-128
[167.554583] Dynamic subtest pipe-D-DP-2-size-128: SUCCESS (2.983s)
[167.611267] Starting dynamic subtest: pipe-D-DP-2-size-256
[170.637751] Dynamic subtest pipe-D-DP-2-size-256: SUCCESS (3.033s)
[170.745699] Subtest viewport: SUCCESS (37.301s)
[170.927462] [033/141] (854s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[171.185277] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[171.187014] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[171.405243] [034/141] (854s left) gem_wait (wait)
[171.477850] Starting subtest: wait
[171.478907] Starting dynamic subtest: all-engines
[172.557968] Dynamic subtest all-engines: SUCCESS (1.080s)
[172.565474] Starting dynamic subtest: rcs0
[173.612967] Dynamic subtest rcs0: SUCCESS (1.053s)
[173.623988] Starting dynamic subtest: bcs0
[174.670573] Dynamic subtest bcs0: SUCCESS (1.053s)
[174.686047] Starting dynamic subtest: vcs0
[175.730594] Dynamic subtest vcs0: SUCCESS (1.056s)
[175.742978] Starting dynamic subtest: vcs1
[176.789384] Dynamic subtest vcs1: SUCCESS (1.055s)
[176.801943] Starting dynamic subtest: vecs0
[177.849555] Dynamic subtest vecs0: SUCCESS (1.056s)
[177.862195] Starting dynamic subtest: vecs1
[178.909505] Dynamic subtest vecs1: SUCCESS (1.056s)
[178.921959] Starting dynamic subtest: ccs0
[179.969429] Dynamic subtest ccs0: SUCCESS (1.056s)
[179.981866] Starting dynamic subtest: ccs1
[181.028775] Dynamic subtest ccs1: SUCCESS (1.056s)
[181.040894] Starting dynamic subtest: ccs2
[182.086530] Dynamic subtest ccs2: SUCCESS (1.055s)
[182.099145] Starting dynamic subtest: ccs3
[183.145572] Dynamic subtest ccs3: SUCCESS (1.055s)
[183.147655] Subtest wait: SUCCESS (11.669s)
[183.398811] [035/141] (842s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs)
[183.652573] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs
[183.654716] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[183.883233] [036/141] (842s left) gem_exec_schedule (u-submit-early-slice)
[183.956676] Starting subtest: u-submit-early-slice
[183.957712] Starting dynamic subtest: rcs0
[184.036787] Dynamic subtest rcs0: SUCCESS (0.080s)
[184.044140] Starting dynamic subtest: bcs0
[184.095639] Dynamic subtest bcs0: SUCCESS (0.058s)
[184.102952] Starting dynamic subtest: vcs0
[184.159280] Dynamic subtest vcs0: SUCCESS (0.063s)
[184.166654] Starting dynamic subtest: vcs1
[184.220757] Dynamic subtest vcs1: SUCCESS (0.061s)
[184.228270] Starting dynamic subtest: vecs0
[184.281603] Dynamic subtest vecs0: SUCCESS (0.060s)
[184.288936] Starting dynamic subtest: vecs1
[184.341312] Dynamic subtest vecs1: SUCCESS (0.059s)
[184.348425] Starting dynamic subtest: ccs0
[184.402720] Dynamic subtest ccs0: SUCCESS (0.060s)
[184.410074] Starting dynamic subtest: ccs1
[184.460742] Dynamic subtest ccs1: SUCCESS (0.057s)
[184.468001] Starting dynamic subtest: ccs2
[184.520696] Dynamic subtest ccs2: SUCCESS (0.059s)
[184.527906] Starting dynamic subtest: ccs3
[184.579955] Dynamic subtest ccs3: SUCCESS (0.058s)
[184.580937] Subtest u-submit-early-slice: SUCCESS (0.624s)
[185.003952] [037/141] (840s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs)
[185.322205] Starting subtest: pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs
[185.324798] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[185.478735] [038/141] (840s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted)
[185.554206] Starting subtest: invalid-multi-wait-all-available-unsubmitted
[185.555141] Subtest invalid-multi-wait-all-available-unsubmitted: SUCCESS (0.000s)
[185.611604] [039/141] (840s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[185.925514] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[185.927388] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[186.090299] [040/141] (839s left) kms_lease (lease_again)
[186.232503] Starting subtest: lease_again
[186.233539] Starting dynamic subtest: pipe-A-DP-2
[186.235977] Dynamic subtest pipe-A-DP-2: SUCCESS (0.002s)
[186.244133] Starting dynamic subtest: pipe-B-DP-2
[186.245074] Dynamic subtest pipe-B-DP-2: SUCCESS (0.001s)
[186.252283] Starting dynamic subtest: pipe-C-DP-2
[186.253187] Dynamic subtest pipe-C-DP-2: SUCCESS (0.002s)
[186.260266] Starting dynamic subtest: pipe-D-DP-2
[186.261235] Dynamic subtest pipe-D-DP-2: SUCCESS (0.001s)
[186.262203] Subtest lease_again: SUCCESS (0.012s)
[186.323736] [041/141] (839s left) perf (short-reads)
[186.660214] Starting subtest: short-reads
[186.679289] Subtest short-reads: SUCCESS (0.020s)
[186.705981] [042/141] (839s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[186.767061] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[186.873831] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[186.940122] [043/141] (839s left) kms_chamelium_color (ctm-0-25)
[187.075146] Subtest ctm-0-25: SKIP (0.000s)
[187.100976] [044/141] (838s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[187.165146] Subtest no-spare-fences-busy: SKIP (0.000s)
[187.184883] [045/141] (838s left) kms_flip (nonexisting-fb)
[187.304734] Starting subtest: nonexisting-fb
[187.307155] Starting dynamic subtest: A-DP2
[187.623004] Dynamic subtest A-DP2: SUCCESS (0.316s)
[187.630261] Starting dynamic subtest: B-DP2
[187.870917] Dynamic subtest B-DP2: SUCCESS (0.247s)
[187.878089] Starting dynamic subtest: C-DP2
[188.117723] Dynamic subtest C-DP2: SUCCESS (0.246s)
[188.125124] Starting dynamic subtest: D-DP2
[188.363430] Dynamic subtest D-DP2: SUCCESS (0.245s)
[188.366094] Subtest nonexisting-fb: SUCCESS (1.063s)
[188.599971] [046/141] (837s left) i915_module_load (reload-no-display)
[188.657772] Starting subtest: reload-no-display
[193.327547] Subtest reload-no-display: SUCCESS (4.659s)
[193.350565] [047/141] (832s left) gem_exec_fence (syncobj-channel)
[194.730992] Starting subtest: syncobj-channel
[195.758877] Subtest syncobj-channel: SUCCESS (1.019s)
[196.045332] [048/141] (830s left) syncobj_wait (reset-unsignaled)
[196.148084] Starting subtest: reset-unsignaled
[196.149028] Subtest reset-unsignaled: SUCCESS (0.000s)
[196.217319] [049/141] (829s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[196.357785] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[196.359594] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[196.426667] [050/141] (829s left) kms_color (ctm-0-25)
[196.561832] Starting subtest: ctm-0-25
[196.562820] Starting dynamic subtest: pipe-A
[198.093109] Dynamic subtest pipe-A: SUCCESS (1.531s)
[198.100285] Starting dynamic subtest: pipe-B
[199.572115] Dynamic subtest pipe-B: SUCCESS (1.479s)
[199.579182] Starting dynamic subtest: pipe-C
[201.036823] Dynamic subtest pipe-C: SUCCESS (1.464s)
[201.044197] Starting dynamic subtest: pipe-D
[202.592368] Dynamic subtest pipe-D: SUCCESS (1.555s)
[202.593338] Subtest ctm-0-25: SUCCESS (6.032s)
[202.767315] [051/141] (823s left) gem_exec_balancer (nop)
[202.837048] Starting subtest: nop
[258.240845] Subtest nop: SUCCESS (55.404s)
[258.503317] [052/141] (767s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-sf)
[258.564678] Subtest cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[258.597328] [053/141] (767s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[258.736228] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[258.737973] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[258.819156] [054/141] (767s left) syncobj_timeline (wait-all-snapshot)
[258.878853] Starting subtest: wait-all-snapshot
[258.960139] Subtest wait-all-snapshot: SUCCESS (0.082s)
[259.056905] [055/141] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[259.205869] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[259.207782] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[259.285422] [056/141] (766s left) v3d/v3d_submit_cl (multiple-job-submission)
[259.371549] Subtest multiple-job-submission: SKIP (0.000s)
[259.420003] [057/141] (766s left) i915_pm_rpm (modeset-lpsp-stress-no-wait)
[261.555084] Starting subtest: modeset-lpsp-stress-no-wait
[267.659004] Subtest modeset-lpsp-stress-no-wait: SUCCESS (6.105s)
[267.806313] [058/141] (758s left) gem_spin_batch (spin-all-new)
[267.880230] Starting subtest: spin-all-new
[283.739255] Subtest spin-all-new: FAIL (15.820s)
[283.944052] [059/141] (742s left) gem_pread (snoop)
[284.017608] Subtest snoop: SKIP (0.000s)
[284.068587] [060/141] (742s left) gem_softpin (noreloc-s3)
[284.137364] Starting subtest: noreloc-S3
[305.444649] Subtest noreloc-S3: SUCCESS (5.433s)
[308.549635] [061/141] (736s left) gem_render_copy_redux (interruptible)
[308.622234] Starting subtest: interruptible
[309.265906] Subtest interruptible: SUCCESS (0.643s)
[309.359132] [062/141] (735s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[309.440290] Starting subtest: stress-mm-invalidate-close-overlap
[311.598141] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[311.693495] [063/141] (733s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[311.868067] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[311.870149] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[311.942550] [064/141] (733s left) gem_eio (kms)
[312.262976] Starting subtest: kms
[329.297473] Subtest kms: SUCCESS (17.035s)
[329.531365] [065/141] (715s left) gem_fence_thrash (bo-write-verify-threaded-x)
[329.597843] Starting subtest: bo-write-verify-threaded-x
[329.600805] Subtest bo-write-verify-threaded-x: SKIP (0.001s)
[329.624668] [066/141] (715s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[329.903426] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[329.905242] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[330.110145] [067/141] (715s left) kms_vblank (pipe-b-wait-idle-hang)
[330.241873] Starting subtest: pipe-B-wait-idle-hang
[332.701109] Subtest pipe-B-wait-idle-hang: SUCCESS (2.460s)
[332.858078] [068/141] (712s left) syncobj_timeline (reset-multiple-signaled)
[332.918553] Starting subtest: reset-multiple-signaled
[332.919754] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[332.974980] [069/141] (712s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[333.109998] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[333.111698] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[333.191310] [070/141] (712s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[333.327009] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[333.328977] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[333.391495] [071/141] (712s left) gem_exec_reloc (basic-cpu)
[333.455254] Subtest basic-cpu: SKIP (0.000s)
[333.502542] [072/141] (711s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[333.799334] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs
[333.801157] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[334.024039] [073/141] (711s left) kms_flip (2x-flip-vs-panning-interruptible)
[334.145223] Starting subtest: 2x-flip-vs-panning-interruptible
[334.165280] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.019s)
[334.225607] [074/141] (711s left) v3d/v3d_perfmon (create-single-perfmon)
[334.305034] Subtest create-single-perfmon: SKIP (0.000s)
[334.353943] [075/141] (711s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[334.491937] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[334.493832] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[334.553935] [076/141] (710s left) gem_exec_fence (syncobj-wait)
[335.305930] Starting subtest: syncobj-wait
[335.451608] Subtest syncobj-wait: SUCCESS (0.137s)
[335.754412] [077/141] (709s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[335.969899] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[335.971841] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[336.231814] [078/141] (709s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[336.367799] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[338.651838] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (2.286s)
[338.788584] [079/141] (706s left) gem_create (create-ext-placement-sanity-check)
[338.968261] Starting subtest: create-ext-placement-sanity-check
[338.969315] Subtest create-ext-placement-sanity-check: SUCCESS (0.002s)
[339.041803] [080/141] (706s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[339.171869] Starting subtest: disable-crc-after-crtc
[339.172900] Starting dynamic subtest: pipe-A-DP-2
[339.777428] Dynamic subtest pipe-A-DP-2: SUCCESS (0.604s)
[339.786143] Starting dynamic subtest: pipe-B-DP-2
[340.361292] Dynamic subtest pipe-B-DP-2: SUCCESS (0.582s)
[340.370894] Starting dynamic subtest: pipe-C-DP-2
[341.011559] Dynamic subtest pipe-C-DP-2: SUCCESS (0.649s)
[341.021593] Starting dynamic subtest: pipe-D-DP-2
[341.723986] Dynamic subtest pipe-D-DP-2: SUCCESS (0.710s)
[341.725197] Subtest disable-crc-after-crtc: SUCCESS (2.552s)
[341.892452] [081/141] (703s left) kms_vblank (pipe-b-wait-forked-busy)
[342.031192] Starting subtest: pipe-B-wait-forked-busy
[344.699090] Subtest pipe-B-wait-forked-busy: SUCCESS (2.668s)
[344.855751] [082/141] (700s left) kms_dsc (dsc-with-bpc)
[344.986991] Starting subtest: dsc-with-bpc
[344.988930] Subtest dsc-with-bpc: SKIP (0.001s)
[345.056121] [083/141] (700s left) gem_mmap_offset (clear)
[345.118961] Starting subtest: clear
[345.119884] Starting dynamic subtest: lmem0
[370.720096] Dynamic subtest lmem0: SUCCESS (25.592s)
[370.737505] Starting dynamic subtest: smem0
[393.544141] Dynamic subtest smem0: SUCCESS (22.831s)
[393.545100] Subtest clear: SUCCESS (48.425s)
[393.940500] [084/141] (651s left) kms_cursor_crc (cursor-onscreen-128x42)
[394.203289] Starting subtest: cursor-onscreen-128x42
[394.208021] Starting dynamic subtest: pipe-A-DP-2
[396.447630] Dynamic subtest pipe-A-DP-2: SUCCESS (2.240s)
[396.476454] Starting dynamic subtest: pipe-D-DP-2
[399.237917] Dynamic subtest pipe-D-DP-2: SUCCESS (2.770s)
[399.238859] Subtest cursor-onscreen-128x42: SUCCESS (5.034s)
[399.521924] [085/141] (646s left) kms_plane (plane-position-hole-dpms)
[399.656748] Starting subtest: plane-position-hole-dpms
[399.657810] Starting dynamic subtest: pipe-A-planes
[402.307901] Dynamic subtest pipe-A-planes: SUCCESS (2.651s)
[402.318968] Starting dynamic subtest: pipe-B-planes
[404.848183] Dynamic subtest pipe-B-planes: SUCCESS (2.539s)
[404.849060] Subtest plane-position-hole-dpms: SUCCESS (5.193s)
[405.032071] [086/141] (640s left) i915_pm_rps (min-max-config-idle)
[405.099256] Starting subtest: min-max-config-idle
[405.101155] Subtest min-max-config-idle: SKIP (0.000s)
[405.168318] [087/141] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[405.318433] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[405.320146] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[405.399220] [088/141] (640s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[405.606267] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[405.714997] [089/141] (640s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[405.835448] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[405.854580] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.018s)
[405.918176] [090/141] (639s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[406.001299] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[406.066316] [091/141] (639s left) kms_cursor_crc (cursor-sliding-max-size)
[406.437843] Starting subtest: cursor-sliding-max-size
[406.442847] Subtest cursor-sliding-max-size: SKIP (0.000s)
[406.633591] [092/141] (639s left) kms_atomic (plane-overlay-legacy)
[407.163128] Starting subtest: plane-overlay-legacy
[407.384318] Subtest plane-overlay-legacy: SUCCESS (0.227s)
[407.639355] [093/141] (638s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[407.831162] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[407.833099] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[407.904623] [094/141] (637s left) kms_cursor_crc (cursor-sliding-128x42)
[408.154885] Starting subtest: cursor-sliding-128x42
[408.159633] Starting dynamic subtest: pipe-A-DP-2
[412.260574] Dynamic subtest pipe-A-DP-2: SUCCESS (4.101s)
[412.289295] Starting dynamic subtest: pipe-D-DP-2
[416.619159] Dynamic subtest pipe-D-DP-2: SUCCESS (4.339s)
[416.620033] Subtest cursor-sliding-128x42: SUCCESS (8.464s)
[416.900781] [095/141] (629s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf_tiled_ccs)
[417.132413] Starting subtest: pipe-A-crc-primary-rotation-180-yf_tiled_ccs
[417.134200] Subtest pipe-A-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[417.398040] [096/141] (628s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[417.534957] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[417.536750] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[417.614066] [097/141] (628s left) kms_flip (absolute-wf_vblank)
[417.733202] Starting subtest: absolute-wf_vblank
[417.736174] Starting dynamic subtest: A-DP2
[425.545409] Dynamic subtest A-DP2: SUCCESS (7.809s)
[425.556635] Starting dynamic subtest: B-DP2
[433.293765] Dynamic subtest B-DP2: SUCCESS (7.748s)
[433.303471] Starting dynamic subtest: C-DP2
[441.040618] Dynamic subtest C-DP2: SUCCESS (7.746s)
[441.050318] Starting dynamic subtest: D-DP2
[448.787448] Dynamic subtest D-DP2: SUCCESS (7.746s)
[448.790138] Subtest absolute-wf_vblank: SUCCESS (31.058s)
[449.026570] [098/141] (596s left) api_intel_bb (object-reloc-purge-cache)
[449.086904] Starting subtest: object-reloc-purge-cache
[449.088631] Subtest object-reloc-purge-cache: SKIP (0.001s)
[449.177257] [099/141] (596s left) gem_exec_suspend (basic-s0)
[449.278539] Starting subtest: basic-S0
[449.279416] Starting dynamic subtest: smem
[469.037464] Dynamic subtest smem: SUCCESS (4.559s)
[469.046891] Starting dynamic subtest: lmem0
[488.120293] Dynamic subtest lmem0: SUCCESS (4.375s)
[488.121807] Subtest basic-S0: SUCCESS (8.935s)
[491.428504] [100/141] (587s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[491.563543] Starting subtest: primary-4-tiled-reflect-x-180
[501.145836] Subtest primary-4-tiled-reflect-x-180: SUCCESS (9.584s)
[501.387935] [101/141] (577s left) kms_vblank (pipe-a-query-forked-hang)
[501.522619] Starting subtest: pipe-A-query-forked-hang
[515.795581] Subtest pipe-A-query-forked-hang: SUCCESS (14.273s)
[515.965942] [102/141] (563s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[516.101174] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[516.102992] Subtest psr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[516.182826] [103/141] (562s left) drm_fdinfo (busy-hang)
[516.245876] Starting subtest: busy-hang
[516.246875] Starting dynamic subtest: rcs0
[516.248756] Dynamic subtest rcs0: SKIP (0.001s)
[516.258621] Starting dynamic subtest: bcs0
[516.260705] Dynamic subtest bcs0: SKIP (0.000s)
[516.269920] Starting dynamic subtest: vcs0
[516.272058] Dynamic subtest vcs0: SKIP (0.000s)
[516.281138] Starting dynamic subtest: vcs1
[516.283038] Dynamic subtest vcs1: SKIP (0.000s)
[516.292224] Starting dynamic subtest: vecs0
[516.294007] Dynamic subtest vecs0: SKIP (0.000s)
[516.304456] Starting dynamic subtest: vecs1
[516.306671] Dynamic subtest vecs1: SKIP (0.000s)
[516.316031] Starting dynamic subtest: ccs0
[516.318265] Dynamic subtest ccs0: SKIP (0.000s)
[516.327633] Starting dynamic subtest: ccs1
[516.329785] Dynamic subtest ccs1: SKIP (0.000s)
[516.339193] Starting dynamic subtest: ccs2
[516.341457] Dynamic subtest ccs2: SKIP (0.000s)
[516.350944] Starting dynamic subtest: ccs3
[516.353163] Dynamic subtest ccs3: SKIP (0.000s)
[516.355460] Subtest busy-hang: SKIP (0.008s)
[516.369663] [104/141] (562s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[516.430669] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[516.460410] [105/141] (562s left) kms_properties (invalid-properties-atomic)
[516.595178] Starting subtest: invalid-properties-atomic
[516.926090] Subtest invalid-properties-atomic: SUCCESS (0.323s)
[516.984668] [106/141] (562s left) syncobj_timeline (invalid-transfer-bad-pad)
[517.045546] Starting subtest: invalid-transfer-bad-pad
[517.046758] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[517.103975] [107/141] (562s left) core_getclient
[517.219120] [108/141] (561s left) kms_content_protection (legacy)
[517.395287] Starting subtest: legacy
[517.605852] Starting dynamic subtest: pipe-A-DP-2
[638.398220] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[638.753286] Closing watchdogs
[638.754214] Initializing watchdogs
[638.754265]   /dev/watchdog0
[638.766277] [109/141] (440s left) i915_pm_lpsp (screens-disabled)
[639.900336] Starting subtest: screens-disabled
[639.902342] Subtest screens-disabled: SKIP (0.000s)
[640.020197] [110/141] (439s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_mc_ccs)
[640.227204] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs
[640.228912] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[640.497890] [111/141] (438s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[640.633822] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[640.635789] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[640.714628] [112/141] (438s left) kms_getfb (getfb-reject-ccs)
[640.775406] Starting subtest: getfb-reject-ccs
[640.777141] Subtest getfb-reject-ccs: SKIP (0.000s)
[640.864234] [113/141] (438s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[641.001413] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[642.257656] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.246s)
[642.368658] [114/141] (436s left) gem_render_copy (linear-to-vebox-yf-tiled)
[642.441918] Starting subtest: linear-to-vebox-yf-tiled
[642.443716] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[642.662546] [115/141] (436s left) dmabuf_sync_file (export-wait-after-attach)
[642.747587] Starting subtest: export-wait-after-attach
[642.748694] Subtest export-wait-after-attach: SUCCESS (0.000s)
[642.805748] [116/141] (436s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-c)
[642.943740] Starting subtest: universal-plane-pageflip-windowed-pipe-C
[643.651615] Subtest universal-plane-pageflip-windowed-pipe-C: SUCCESS (0.709s)
[643.843074] [117/141] (435s left) gem_exec_schedule (pi-userfault)
[644.029678] Starting subtest: pi-userfault
[644.031100] Starting dynamic subtest: rcs0
[644.041207] Dynamic subtest rcs0: SUCCESS (0.012s)
[644.057608] Starting dynamic subtest: bcs0
[644.058576] Dynamic subtest bcs0: SUCCESS (0.009s)
[644.068566] Starting dynamic subtest: vcs0
[644.069512] Dynamic subtest vcs0: SUCCESS (0.005s)
[644.079830] Starting dynamic subtest: vcs1
[644.080823] Dynamic subtest vcs1: SUCCESS (0.005s)
[644.091183] Starting dynamic subtest: vecs0
[644.092087] Dynamic subtest vecs0: SUCCESS (0.006s)
[644.103060] Starting dynamic subtest: vecs1
[644.103989] Dynamic subtest vecs1: SUCCESS (0.008s)
[644.114517] Starting dynamic subtest: ccs0
[644.115609] Dynamic subtest ccs0: SUCCESS (0.010s)
[644.125499] Starting dynamic subtest: ccs1
[644.126658] Dynamic subtest ccs1: SUCCESS (0.005s)
[644.136419] Starting dynamic subtest: ccs2
[644.137680] Dynamic subtest ccs2: SUCCESS (0.005s)
[644.147233] Starting dynamic subtest: ccs3
[644.148312] Dynamic subtest ccs3: SUCCESS (0.008s)
[644.149232] Subtest pi-userfault: SUCCESS (0.080s)
[644.329265] [118/141] (435s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[644.396567] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[644.398447] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[644.571955] [119/141] (434s left) gem_ctx_bad_destroy (invalid-pad)
[644.632716] Starting subtest: invalid-pad
[644.633616] Subtest invalid-pad: SUCCESS (0.000s)
[644.696906] [120/141] (434s left) prime_mmap (test_map_unmap)
[644.763152] Starting subtest: test_map_unmap
[644.764058] Starting dynamic subtest: test_map_unmap-smem
[644.824397] Dynamic subtest test_map_unmap-smem: SUCCESS (0.061s)
[644.834555] Starting dynamic subtest: test_map_unmap-lmem0
[645.084164] Dynamic subtest test_map_unmap-lmem0: SUCCESS (0.250s)
[645.085266] Subtest test_map_unmap: SUCCESS (0.313s)
[645.171841] [121/141] (434s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[645.315662] Starting subtest: psr-rgb101010-draw-blt
[645.317570] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[645.393590] [122/141] (434s left) perf_pmu (pmu-read)
[645.456565] Starting subtest: pmu-read
[645.459472] Subtest pmu-read: SUCCESS (0.003s)
[645.541931] [123/141] (433s left) gem_eio (in-flight-1us)
[645.815923] Starting subtest: in-flight-1us
[650.821346] Subtest in-flight-1us: SUCCESS (5.005s)
[650.960562] [124/141] (428s left) gem_ctx_persistence (file)
[651.026990] Starting subtest: file
[651.121169] Subtest file: SUCCESS (0.094s)
[651.243972] [125/141] (428s left) kms_universal_plane (cursor-fb-leak-pipe-d)
[651.406012] Starting subtest: cursor-fb-leak-pipe-D
[652.162929] Subtest cursor-fb-leak-pipe-D: SUCCESS (0.758s)
[652.360916] [126/141] (427s left) gem_exec_whisper (basic-sync-all)
[652.430770] Starting subtest: basic-sync-all
[674.182607] Subtest basic-sync-all: SUCCESS (21.749s)
[674.369238] [127/141] (405s left) gem_eio (in-flight-10ms)
[674.668033] Starting subtest: in-flight-10ms
[680.259204] Subtest in-flight-10ms: SUCCESS (5.592s)
[680.395803] [128/141] (399s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_mc_ccs)
[680.639542] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs
[685.605578] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs: SUCCESS (4.966s)
[685.934657] [129/141] (393s left) syncobj_basic (test-valid-cycle)
[685.995880] Starting subtest: test-valid-cycle
[685.996902] Subtest test-valid-cycle: SUCCESS (0.000s)
[686.050160] [130/141] (393s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs)
[686.380051] Starting subtest: pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs
[686.381898] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[686.527954] [131/141] (393s left) prime_vgem (shrink)
[686.598825] Starting subtest: shrink
[686.606565] Subtest shrink: SUCCESS (0.007s)
[686.701125] [132/141] (393s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[686.867250] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[686.869171] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[686.960840] [133/141] (392s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[687.094321] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[687.095458] Starting dynamic subtest: pipe-A-valid-mode
[689.637807] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.542s)
[689.639150] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (2.544s)
[689.810019] [134/141] (389s left) kms_big_fb (linear-16bpp-rotate-0)
[689.946710] Starting subtest: linear-16bpp-rotate-0
[691.576266] Subtest linear-16bpp-rotate-0: SUCCESS (1.629s)
[691.686698] [135/141] (388s left) gem_pxp (create-regular-context-1)
[694.323130] Subtest create-regular-context-1: SKIP (0.000s)
[694.353029] [136/141] (385s left) kms_fbcon_fbt (psr-suspend)
[694.417254] Starting subtest: psr-suspend
[694.419360] Subtest psr-suspend: SKIP (0.000s)
[694.497590] [137/141] (385s left) feature_discovery (display-3x)
[694.654235] Starting subtest: display-3x
[694.656099] Subtest display-3x: SKIP (0.000s)
[694.709606] [138/141] (385s left) kms_writeback (writeback-check-output)
[694.909193] Subtest writeback-check-output: SKIP (0.000s)
[694.937254] [139/141] (384s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[695.068588] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[695.069587] Starting dynamic subtest: pipe-A-DP-2
[695.157910] Dynamic subtest pipe-A-DP-2: SUCCESS (0.089s)
[695.169707] Starting dynamic subtest: pipe-B-DP-2
[695.347336] Dynamic subtest pipe-B-DP-2: SUCCESS (0.188s)
[695.358855] Starting dynamic subtest: pipe-C-DP-2
[695.537105] Dynamic subtest pipe-C-DP-2: SUCCESS (0.188s)
[695.551920] Starting dynamic subtest: pipe-D-DP-2
[695.727500] Dynamic subtest pipe-D-DP-2: SUCCESS (0.189s)
[695.728545] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.660s)
[695.935778] [140/141] (383s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[696.017856] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[696.068741] [141/141] (383s left) sw_sync (sync_busy)
[696.126450] Starting subtest: sync_busy
[696.128936] Subtest sync_busy: SUCCESS (0.002s)
[696.166140] Closing watchdogs
Done.