[44.999661] Initializing watchdogs
[44.999981]   /dev/watchdog0
[45.016734] [001/142] (960s left) kms_universal_plane (universal-plane-pipe-d-sanity)
[45.348368] Subtest universal-plane-pipe-D-sanity: SKIP (0.000s)
[45.432614] [002/142] (960s left) kms_invalid_mode (bad-hsync-end)
[45.737475] Starting subtest: bad-hsync-end
[45.738949] Starting dynamic subtest: DP-1-pipe-A
[45.848171] Dynamic subtest DP-1-pipe-A: SUCCESS (0.110s)
[45.862857] Starting dynamic subtest: DP-1-pipe-B
[45.864904] Dynamic subtest DP-1-pipe-B: SUCCESS (0.013s)
[45.879717] Starting dynamic subtest: DP-1-pipe-C
[45.881116] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[45.882355] Subtest bad-hsync-end: SUCCESS (0.144s)
[46.210637] [003/142] (959s left) kms_async_flips (async-flip-with-page-flip-events)
[46.511695] Starting subtest: async-flip-with-page-flip-events
[46.997995] Starting dynamic subtest: pipe-A-DP-1-Yf-CCS
[47.850136] Dynamic subtest pipe-A-DP-1-Yf-CCS: SKIP (0.850s)
[47.865861] Starting dynamic subtest: pipe-A-DP-1-Y-CCS
[48.494676] Dynamic subtest pipe-A-DP-1-Y-CCS: SKIP (0.645s)
[48.512660] Starting dynamic subtest: pipe-A-DP-1-Yf
[51.127514] Dynamic subtest pipe-A-DP-1-Yf: SUCCESS (2.633s)
[51.140907] Starting dynamic subtest: pipe-A-DP-1-Y
[53.744569] Dynamic subtest pipe-A-DP-1-Y: SUCCESS (2.616s)
[53.758633] Starting dynamic subtest: pipe-A-DP-1-X
[56.395114] Dynamic subtest pipe-A-DP-1-X: SUCCESS (2.649s)
[56.409217] Starting dynamic subtest: pipe-A-DP-1-linear
[56.562411] Dynamic subtest pipe-A-DP-1-linear: SKIP (0.168s)
[57.040861] Starting dynamic subtest: pipe-B-DP-1-Yf-CCS
[57.935198] Dynamic subtest pipe-B-DP-1-Yf-CCS: SKIP (0.903s)
[57.949159] Starting dynamic subtest: pipe-B-DP-1-Y-CCS
[58.546474] Dynamic subtest pipe-B-DP-1-Y-CCS: SKIP (0.611s)
[58.564271] Starting dynamic subtest: pipe-B-DP-1-Yf
[61.160550] Dynamic subtest pipe-B-DP-1-Yf: SUCCESS (2.614s)
[61.173882] Starting dynamic subtest: pipe-B-DP-1-Y
[63.760854] Dynamic subtest pipe-B-DP-1-Y: SUCCESS (2.599s)
[63.775306] Starting dynamic subtest: pipe-B-DP-1-X
[66.428108] Dynamic subtest pipe-B-DP-1-X: SUCCESS (2.666s)
[66.441422] Starting dynamic subtest: pipe-B-DP-1-linear
[66.560438] Dynamic subtest pipe-B-DP-1-linear: SKIP (0.134s)
[66.917886] Starting dynamic subtest: pipe-C-DP-1-Yf
[69.743850] Dynamic subtest pipe-C-DP-1-Yf: SUCCESS (2.837s)
[69.757396] Starting dynamic subtest: pipe-C-DP-1-Y
[72.329153] Dynamic subtest pipe-C-DP-1-Y: SUCCESS (2.579s)
[72.342415] Starting dynamic subtest: pipe-C-DP-1-X
[74.973102] Dynamic subtest pipe-C-DP-1-X: SUCCESS (2.649s)
[74.986227] Starting dynamic subtest: pipe-C-DP-1-linear
[75.123434] Dynamic subtest pipe-C-DP-1-linear: SKIP (0.151s)
[75.124792] Subtest async-flip-with-page-flip-events: SUCCESS (28.612s)
[75.678100] [004/142] (929s left) kms_prime (basic-modeset-hybrid)
[77.763531] Subtest basic-modeset-hybrid: SKIP (0.000s)
[77.914525] [005/142] (927s left) vc4/vc4_wait_bo (used-bo-0ns)
[78.178684] Subtest used-bo-0ns: SKIP (0.000s)
[78.242712] [006/142] (927s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[78.550232] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[81.227988] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.678s)
[81.360151] [007/142] (924s left) kms_cursor_crc (cursor-onscreen-64x64)
[81.676659] Starting subtest: cursor-onscreen-64x64
[81.686407] Starting dynamic subtest: pipe-A-DP-1
[84.257939] Dynamic subtest pipe-A-DP-1: SUCCESS (2.571s)
[84.338547] Starting dynamic subtest: pipe-C-DP-1
[87.016574] Dynamic subtest pipe-C-DP-1: SUCCESS (2.691s)
[87.018195] Subtest cursor-onscreen-64x64: SUCCESS (5.341s)
[87.368696] [008/142] (918s left) gem_lmem_swapping (heavy-verify-random-ccs)
[87.592340] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[87.647413] [009/142] (918s left) gem_exec_reloc (basic-write-gtt)
[87.860578] Starting subtest: basic-write-gtt
[87.880420] Subtest basic-write-gtt: SUCCESS (0.019s)
[88.065644] [010/142] (917s left) kms_pwrite_crc
[89.282800] [011/142] (916s left) syncobj_timeline (multi-wait-all-available-submitted)
[89.487426] Starting subtest: multi-wait-all-available-submitted
[89.490894] Subtest multi-wait-all-available-submitted: SUCCESS (0.002s)
[89.563288] [012/142] (916s left) perf (oa-formats)
[89.902146] Starting subtest: oa-formats
[89.904159] Starting dynamic subtest: 0-rcs0
[90.098738] Dynamic subtest 0-rcs0: SUCCESS (0.197s)
[90.100201] Subtest oa-formats: SUCCESS (0.197s)
[90.145284] [013/142] (915s left) kms_vblank (pipe-a-query-busy-hang)
[90.441891] Starting subtest: pipe-A-query-busy-hang
[97.010824] Subtest pipe-A-query-busy-hang: SUCCESS (6.569s)
[97.337505] [014/142] (908s left) gem_eio (in-flight-internal-immediate)
[97.574151] Starting subtest: in-flight-internal-immediate
[97.662657] Subtest in-flight-internal-immediate: SUCCESS (0.091s)
[97.855782] [015/142] (908s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[98.061404] Starting subtest: etime-multi-wait-all-for-submit-submitted
[98.165223] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[98.255041] [016/142] (907s left) gem_exec_reloc (basic-gtt-cpu)
[98.466509] Starting subtest: basic-gtt-cpu
[98.488527] Subtest basic-gtt-cpu: SUCCESS (0.021s)
[98.671507] [017/142] (907s left) gem_exec_whisper (basic-fds-priority-all)
[98.900626] Starting subtest: basic-fds-priority-all
[122.902691] Subtest basic-fds-priority-all: SUCCESS (24.000s)
[123.106483] [018/142] (882s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[123.428660] Starting subtest: yf-tiled-64bpp-rotate-90
[123.431602] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[123.523525] [019/142] (882s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[123.833982] Starting subtest: fbcpsr-tiling-y
[123.836428] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[123.940122] [020/142] (882s left) gem_exec_balancer (nohangcheck)
[127.965083] Starting subtest: nohangcheck
[131.661421] Subtest nohangcheck: SUCCESS (3.696s)
[131.740940] [021/142] (874s left) gem_exec_reloc (basic-write-cpu)
[131.952822] Starting subtest: basic-write-cpu
[131.969382] Subtest basic-write-cpu: SUCCESS (0.016s)
[132.157919] [022/142] (874s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[132.466733] Starting subtest: fbc-rgb101010-draw-pwrite
[135.119788] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.654s)
[135.241216] [023/142] (871s left) drm_fdinfo (virtual-busy-hang)
[135.451769] Starting subtest: virtual-busy-hang
[139.678830] Subtest virtual-busy-hang: SUCCESS (4.226s)
[139.755412] [024/142] (866s left) kms_selftest (drm_dp_mst)
[139.952723] Starting subtest: drm_dp_mst
[139.958466] Subtest drm_dp_mst: SKIP (0.004s)
[140.023690] [025/142] (866s left) gem_exec_fair (basic-throttle)
[140.255207] Starting subtest: basic-throttle
[140.256574] Starting dynamic subtest: rcs0
[145.393219] Dynamic subtest rcs0: SUCCESS (5.137s)
[145.394713] Subtest basic-throttle: SUCCESS (5.138s)
[145.589694] [026/142] (860s left) gem_ctx_engines (execute-one)
[145.818166] Starting subtest: execute-one
[148.817362] Subtest execute-one: SUCCESS (2.999s)
[149.058770] [027/142] (857s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs)
[149.717471] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[150.029751] [028/142] (856s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_ccs)
[150.688276] Subtest pipe-D-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[151.007540] [029/142] (855s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[151.326157] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[152.701300] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.376s)
[152.858986] [030/142] (853s left) gem_render_copy_redux (interruptible)
[153.087591] Starting subtest: interruptible
[155.391247] Subtest interruptible: SUCCESS (2.302s)
[155.508476] [031/142] (851s left) perf_pmu (gt-awake)
[155.719025] Starting subtest: gt-awake
[158.272606] Subtest gt-awake: SUCCESS (2.554s)
[158.389527] [032/142] (848s left) kms_flip (2x-absolute-wf_vblank)
[158.672216] Starting subtest: 2x-absolute-wf_vblank
[158.674685] Subtest 2x-absolute-wf_vblank: SKIP (0.003s)
[158.791401] [033/142] (847s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[159.010680] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[159.013517] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[159.206939] [034/142] (847s left) sw_sync (sync_multi_consumer)
[159.404446] Starting subtest: sync_multi_consumer
[160.437919] Subtest sync_multi_consumer: SUCCESS (1.032s)
[160.506722] [035/142] (846s left) gen9_exec_parse (unaligned-access)
[160.735764] Starting subtest: unaligned-access
[160.807293] Subtest unaligned-access: SUCCESS (0.072s)
[161.040357] [036/142] (845s left) i915_pm_rc6_residency (rc6-accuracy)
[161.410278] Starting subtest: rc6-accuracy
[164.447273] Subtest rc6-accuracy: SUCCESS (3.001s)
[164.490114] [037/142] (842s left) kms_getfb (getfb-handle-valid)
[164.696339] Starting subtest: getfb-handle-valid
[164.697876] Subtest getfb-handle-valid: SUCCESS (0.000s)
[164.789576] [038/142] (842s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[165.016409] Starting subtest: yf-tiled-ccs-to-y-tiled
[165.017895] Starting dynamic subtest: smem
[165.333053] Dynamic subtest smem: SUCCESS (0.316s)
[165.334389] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.317s)
[165.543230] [039/142] (841s left) gem_sync (basic-each)
[165.769103] Starting subtest: basic-each
[168.108355] Subtest basic-each: SUCCESS (2.339s)
[168.307602] [040/142] (838s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[168.970854] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[169.287760] [041/142] (837s left) kms_vblank (pipe-a-ts-continuation-dpms-suspend)
[169.587106] Starting subtest: pipe-A-ts-continuation-dpms-suspend
[186.613776] Subtest pipe-A-ts-continuation-dpms-suspend: SUCCESS (2.459s)
[192.239561] [042/142] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[192.556366] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[192.558891] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[192.665948] [043/142] (833s left) prime_self_import (basic-with_two_bos)
[192.866477] Starting subtest: basic-with_two_bos
[192.873364] Subtest basic-with_two_bos: SUCCESS (0.009s)
[192.982179] [044/142] (833s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[193.300599] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[193.303773] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[193.399134] [045/142] (833s left) perf (gen12-mi-rpc)
[193.694322] Subtest gen12-mi-rpc: SKIP (0.000s)
[193.747852] [046/142] (832s left) kms_color (ctm-max)
[194.046170] Starting subtest: ctm-max
[194.047439] Starting dynamic subtest: pipe-A
[194.553942] Dynamic subtest pipe-A: SUCCESS (0.511s)
[194.576073] Starting dynamic subtest: pipe-B
[195.349275] Dynamic subtest pipe-B: SUCCESS (0.794s)
[195.372587] Starting dynamic subtest: pipe-C
[196.302369] Dynamic subtest pipe-C: SUCCESS (0.952s)
[196.303657] Subtest ctm-max: SUCCESS (2.259s)
[196.640253] [047/142] (830s left) gem_eio (in-flight-contexts-immediate)
[196.860995] Starting subtest: in-flight-contexts-immediate
[208.776676] Subtest in-flight-contexts-immediate: SUCCESS (11.918s)
[208.995499] [048/142] (817s left) gem_exec_balancer (bonded-sync)
[209.222840] Starting subtest: bonded-sync
[212.968494] Subtest bonded-sync: SUCCESS (3.744s)
[216.856755] [049/142] (809s left) kms_vblank (pipe-b-accuracy-idle)
[217.156185] Starting subtest: pipe-B-accuracy-idle
[219.854162] Subtest pipe-B-accuracy-idle: SUCCESS (2.698s)
[220.185149] [050/142] (806s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[220.616437] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[220.619254] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[221.168744] [051/142] (805s left) sysfs_preempt_timeout (timeout)
[221.377080] Starting subtest: timeout
[221.380671] Starting dynamic subtest: vecs0
[222.264104] Dynamic subtest vecs0: SUCCESS (0.884s)
[222.290332] Starting dynamic subtest: vcs0
[223.137714] Dynamic subtest vcs0: SUCCESS (0.871s)
[223.166415] Starting dynamic subtest: bcs0
[224.024355] Dynamic subtest bcs0: SUCCESS (0.885s)
[224.046231] Starting dynamic subtest: rcs0
[224.906957] Dynamic subtest rcs0: SUCCESS (0.880s)
[224.908347] Subtest timeout: SUCCESS (3.528s)
[225.000355] [052/142] (801s left) kms_flip (flip-vs-absolute-wf_vblank)
[225.285890] Starting subtest: flip-vs-absolute-wf_vblank
[225.287303] Starting dynamic subtest: A-DP1
[236.109134] Dynamic subtest A-DP1: SUCCESS (10.821s)
[236.131858] Starting dynamic subtest: B-DP1
[246.881461] Dynamic subtest B-DP1: SUCCESS (10.773s)
[246.906694] Starting dynamic subtest: C-DP1
[257.621607] Dynamic subtest C-DP1: SUCCESS (10.738s)
[257.625246] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.342s)
[258.056168] [053/142] (768s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[258.258599] Starting subtest: multi-wait-available-submitted-signaled
[258.260113] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.002s)
[258.353953] [054/142] (768s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[258.653616] Starting subtest: cursor-rapid-movement-64x21
[258.664681] Starting dynamic subtest: pipe-A-DP-1
[259.177255] Dynamic subtest pipe-A-DP-1: SUCCESS (0.510s)
[259.261587] Starting dynamic subtest: pipe-C-DP-1
[260.070536] Dynamic subtest pipe-C-DP-1: SUCCESS (0.828s)
[260.071806] Subtest cursor-rapid-movement-64x21: SUCCESS (1.414s)
[260.437148] [055/142] (766s left) kms_addfb_basic (no-handle)
[260.641465] Starting subtest: no-handle
[260.642945] Subtest no-handle: SUCCESS (0.000s)
[260.833105] [056/142] (766s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_rc_ccs)
[261.278778] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs
[261.281490] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[261.816443] [057/142] (765s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_rc_ccs)
[262.306743] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs
[262.310646] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[262.846365] [058/142] (764s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[263.374887] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[263.377891] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[263.827350] [059/142] (763s left) kms_big_fb (4-tiled-addfb-size-overflow)
[264.153794] Starting subtest: 4-tiled-addfb-size-overflow
[264.156995] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[264.259689] [060/142] (763s left) kms_rotation_crc (bad-tiling)
[264.560311] Starting subtest: bad-tiling
[269.021400] Subtest bad-tiling: SUCCESS (4.464s)
[269.431680] [061/142] (757s left) kms_chamelium_hpd (dp-hpd)
[269.838716] Subtest dp-hpd: SKIP (0.000s)
[270.135685] [062/142] (757s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[270.441313] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[270.444378] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[270.547877] [063/142] (756s left) gem_ctx_sseu (invalid-sseu)
[270.755978] Subtest invalid-sseu: SKIP (0.000s)
[270.813546] [064/142] (756s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[271.014625] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[271.063259] [065/142] (756s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[271.361740] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[271.363124] Starting dynamic subtest: pipe-A-valid-mode
[272.143099] Dynamic subtest pipe-A-valid-mode: SKIP (0.777s)
[272.145732] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.781s)
[272.550643] [066/142] (755s left) kms_atomic_interruptible (universal-setplane-primary)
[272.859486] Starting subtest: universal-setplane-primary
[272.864203] Starting dynamic subtest: DP-1-pipe-A
[279.411466] Dynamic subtest DP-1-pipe-A: SUCCESS (6.548s)
[279.412994] Subtest universal-setplane-primary: SUCCESS (6.553s)
[279.743755] [067/142] (747s left) syncobj_wait (invalid-reset-zero-handles)
[279.950514] Starting subtest: invalid-reset-zero-handles
[279.952563] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[280.043231] [068/142] (747s left) kms_display_modes (extended-mode-basic)
[280.348522] Starting subtest: extended-mode-basic
[280.351369] Subtest extended-mode-basic: SKIP (0.000s)
[280.408662] [069/142] (747s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[280.719917] Starting subtest: psr-rgb565-draw-blt
[280.723006] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[280.827157] [070/142] (746s left) gem_tiled_blits (interruptible)
[283.061391] Starting subtest: interruptible
[336.429068] Subtest interruptible: SUCCESS (53.367s)
[336.548789] [071/142] (691s left) gem_exec_schedule (noreorder)
[337.056828] Starting subtest: noreorder
[337.058368] Starting dynamic subtest: rcs0
[337.111675] Dynamic subtest rcs0: SUCCESS (0.054s)
[337.139570] Starting dynamic subtest: bcs0
[337.166663] Dynamic subtest bcs0: SUCCESS (0.052s)
[337.195333] Starting dynamic subtest: vcs0
[337.223083] Dynamic subtest vcs0: SUCCESS (0.054s)
[337.253079] Starting dynamic subtest: vecs0
[337.280597] Dynamic subtest vecs0: SUCCESS (0.054s)
[337.282391] Subtest noreorder: SUCCESS (0.225s)
[337.494589] [072/142] (690s left) prime_self_import (export-vs-gem_close-race)
[337.689388] Starting subtest: export-vs-gem_close-race
[342.718748] Subtest export-vs-gem_close-race: SUCCESS (5.028s)
[342.811742] [073/142] (685s left) kms_vblank (pipe-b-wait-forked-busy)
[343.116975] Starting subtest: pipe-B-wait-forked-busy
[345.988354] Subtest pipe-B-wait-forked-busy: SUCCESS (2.875s)
[346.327616] [074/142] (681s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[346.655666] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[348.197598] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.544s)
[348.545789] [075/142] (679s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-5)
[348.844805] Starting subtest: plane-downscale-with-rotation-factor-0-5
[348.846209] Starting dynamic subtest: pipe-A-DP-1
[349.177343] Dynamic subtest pipe-A-DP-1: SKIP (0.327s)
[349.201850] Starting dynamic subtest: pipe-B-DP-1
[349.563828] Dynamic subtest pipe-B-DP-1: SKIP (0.383s)
[349.592115] Starting dynamic subtest: pipe-C-DP-1
[349.943295] Dynamic subtest pipe-C-DP-1: SKIP (0.376s)
[349.945939] Subtest plane-downscale-with-rotation-factor-0-5: SKIP (1.100s)
[350.372735] [076/142] (677s left) dmabuf (all-tests)
[350.578348] Starting subtest: all-tests
[350.579875] Starting dynamic subtest: sanitycheck
[350.662349] Dynamic subtest sanitycheck: SUCCESS (0.083s)
[350.688125] Starting dynamic subtest: dma_fence
[350.853322] Dynamic subtest dma_fence: SUCCESS (0.189s)
[350.877648] Starting dynamic subtest: dma_fence_chain
[375.387510] Dynamic subtest dma_fence_chain: SUCCESS (24.531s)
[375.417855] Starting dynamic subtest: dma_fence_unwrap
[375.454491] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s)
[375.486565] Starting dynamic subtest: dma_resv
[375.527376] Dynamic subtest dma_resv: SUCCESS (0.069s)
[375.528847] Subtest all-tests: SUCCESS (24.951s)
[375.605557] [077/142] (652s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[375.933192] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[375.936085] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[376.038804] [078/142] (652s left) kms_force_connector_basic (force-connector-state)
[376.241007] Subtest force-connector-state: SKIP (0.000s)
[376.305388] [079/142] (651s left) kms_chamelium_color (ctm-max)
[376.604436] Subtest ctm-max: SKIP (0.000s)
[376.656333] [080/142] (651s left) gem_busy (busy)
[376.883422] Starting subtest: busy
[376.884987] Starting dynamic subtest: all-engines
[376.975264] Dynamic subtest all-engines: SUCCESS (0.089s)
[376.998672] Starting dynamic subtest: rcs0
[377.000351] Dynamic subtest rcs0: SUCCESS (0.022s)
[377.025788] Starting dynamic subtest: bcs0
[377.027157] Dynamic subtest bcs0: SUCCESS (0.019s)
[377.050478] Starting dynamic subtest: vcs0
[377.052084] Dynamic subtest vcs0: SUCCESS (0.010s)
[377.075274] Starting dynamic subtest: vecs0
[377.076626] Dynamic subtest vecs0: SUCCESS (0.018s)
[377.077867] Subtest busy: SUCCESS (0.171s)
[377.438557] [081/142] (650s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[377.745639] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[377.748739] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[377.872434] [082/142] (650s left) v3d/v3d_submit_cl (single-out-sync)
[378.128281] Subtest single-out-sync: SKIP (0.000s)
[378.204255] [083/142] (650s left) kms_color (legacy-gamma-reset)
[378.504711] Starting subtest: legacy-gamma-reset
[378.505986] Starting dynamic subtest: pipe-A
[378.978866] Dynamic subtest pipe-A: SUCCESS (0.473s)
[379.001782] Starting dynamic subtest: pipe-B
[379.363378] Dynamic subtest pipe-B: SUCCESS (0.381s)
[379.386455] Starting dynamic subtest: pipe-C
[379.750196] Dynamic subtest pipe-C: SUCCESS (0.386s)
[379.751509] Subtest legacy-gamma-reset: SUCCESS (1.247s)
[380.076397] [084/142] (648s left) kms_flip (2x-flip-vs-dpms)
[380.362901] Starting subtest: 2x-flip-vs-dpms
[380.365489] Subtest 2x-flip-vs-dpms: SKIP (0.003s)
[380.492853] [085/142] (647s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[380.792633] Starting subtest: 2x-flip-vs-cursor-atomic
[380.795363] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.004s)
[380.892867] [086/142] (647s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[381.198204] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[383.497946] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (2.303s)
[383.642230] [087/142] (644s left) api_intel_allocator (simple-allocator)
[383.847801] Starting subtest: simple-allocator
[383.849485] Starting dynamic subtest: basic
[383.857162] Dynamic subtest basic: SUCCESS (0.006s)
[383.881598] Starting dynamic subtest: parallel-one
[384.003979] Dynamic subtest parallel-one: SUCCESS (0.147s)
[384.031693] Starting dynamic subtest: print
[384.032996] Dynamic subtest print: SUCCESS (0.000s)
[384.055535] Starting dynamic subtest: reuse
[384.057209] Dynamic subtest reuse: SUCCESS (0.000s)
[384.080522] Starting dynamic subtest: reserve
[384.081865] Dynamic subtest reserve: SUCCESS (0.000s)
[384.104419] Starting dynamic subtest: fork-reopen-allocator
[384.105673] Dynamic subtest fork-reopen-allocator: SUCCESS (0.042s)
[384.106890] Subtest simple-allocator: SUCCESS (0.211s)
[384.160261] [088/142] (644s left) perf_pmu (multi-client)
[384.371783] Starting subtest: multi-client
[384.373396] Starting dynamic subtest: rcs0
[385.402847] Dynamic subtest rcs0: SUCCESS (1.029s)
[385.429895] Starting dynamic subtest: bcs0
[386.432363] Dynamic subtest bcs0: SUCCESS (1.026s)
[386.458478] Starting dynamic subtest: vcs0
[387.464265] Dynamic subtest vcs0: SUCCESS (1.029s)
[387.491623] Starting dynamic subtest: vecs0
[388.501966] Dynamic subtest vecs0: SUCCESS (1.034s)
[388.503739] Subtest multi-client: SUCCESS (4.132s)
[388.607925] [089/142] (639s left) kms_psr (psr2_primary_page_flip)
[388.812887] Subtest psr2_primary_page_flip: SKIP (0.000s)
[388.873879] [090/142] (639s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[389.168547] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[389.169902] Starting dynamic subtest: pipe-A-valid-mode
[389.329412] Dynamic subtest pipe-A-valid-mode: SKIP (0.158s)
[389.332032] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.162s)
[389.679946] [091/142] (638s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs)
[390.250769] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs
[390.253504] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[390.667953] [092/142] (638s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[390.968439] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[390.973557] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.003s)
[391.085654] [093/142] (637s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[391.390131] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[391.391579] Starting dynamic subtest: pipe-A-DP-1
[391.489616] Dynamic subtest pipe-A-DP-1: SUCCESS (0.097s)
[391.518899] Starting dynamic subtest: pipe-B-DP-1
[391.880618] Dynamic subtest pipe-B-DP-1: SUCCESS (0.386s)
[391.907727] Starting dynamic subtest: pipe-C-DP-1
[392.261548] Dynamic subtest pipe-C-DP-1: SUCCESS (0.377s)
[392.263281] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.875s)
[392.675850] [094/142] (636s left) i915_pm_rps (basic-api)
[392.888510] Starting subtest: basic-api
[392.895798] Subtest basic-api: SUCCESS (0.007s)
[393.009156] [095/142] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[393.312402] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[393.315322] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[393.425720] [096/142] (635s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[393.973766] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[393.980099] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.005s)
[394.415441] [097/142] (634s left) core_getstats
[394.698616] [098/142] (634s left) kms_big_fb (linear-64bpp-rotate-180)
[395.022349] Starting subtest: linear-64bpp-rotate-180
[403.336781] Subtest linear-64bpp-rotate-180: SUCCESS (8.314s)
[404.267610] [099/142] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[404.588047] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[404.590588] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[404.699961] [100/142] (624s left) gen7_exec_parse (cmd-crossing-page)
[404.925044] Subtest cmd-crossing-page: SKIP (0.000s)
[404.981678] [101/142] (624s left) i915_pm_rpm (modeset-lpsp-stress)
[406.888908] Starting subtest: modeset-lpsp-stress
[407.502139] Subtest modeset-lpsp-stress: SKIP (0.607s)
[407.980524] [102/142] (621s left) v3d/v3d_submit_cl (bad-extension)
[408.233399] Subtest bad-extension: SKIP (0.000s)
[408.311334] [103/142] (620s left) fbdev (read)
[408.517463] Starting subtest: read
[409.928492] Subtest read: SUCCESS (1.410s)
[410.012425] [104/142] (619s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[410.322514] Starting subtest: basic-max-pipe-crc-check
[410.325451] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[410.376967] [105/142] (618s left) kms_atomic (plane-invalid-params-fence)
[410.795825] Starting subtest: plane-invalid-params-fence
[410.832317] Subtest plane-invalid-params-fence: SUCCESS (0.037s)
[411.275993] [106/142] (618s left) syncobj_timeline (wait-any-complex)
[411.479898] Starting subtest: wait-any-complex
[411.544419] Subtest wait-any-complex: SUCCESS (0.064s)
[411.640821] [107/142] (617s left) kms_plane_lowres (tiling-x)
[411.937708] Starting subtest: tiling-x
[411.938990] Starting dynamic subtest: pipe-A-DP-1
[418.299628] Dynamic subtest pipe-A-DP-1: SUCCESS (6.361s)
[418.423094] Starting dynamic subtest: pipe-B-DP-1
[424.698999] Dynamic subtest pipe-B-DP-1: SUCCESS (6.298s)
[424.821978] Starting dynamic subtest: pipe-C-DP-1
[429.023941] Dynamic subtest pipe-C-DP-1: SUCCESS (4.224s)
[429.138085] Subtest tiling-x: SUCCESS (17.202s)
[429.628585] [108/142] (599s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[429.837347] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[429.841480] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[429.943124] [109/142] (599s left) gem_mmap_gtt (cpuset-big-copy-odd)
[430.146960] Starting subtest: cpuset-big-copy-odd
[453.236928] Subtest cpuset-big-copy-odd: SUCCESS (23.089s)
[453.680401] [110/142] (575s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_mc_ccs)
[454.333188] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs
[454.337469] Subtest pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[454.805339] [111/142] (574s left) i915_module_load (load)
[455.006505] Starting subtest: load
[455.022162] Subtest load: SKIP (0.015s)
[455.102977] [112/142] (574s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[455.733882] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[455.736995] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[456.136111] [113/142] (573s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[456.447289] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[456.450487] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[456.568302] [114/142] (573s left) gem_exec_schedule (timeslicing)
[456.802516] Starting subtest: timeslicing
[456.806818] Starting dynamic subtest: rcs0
[456.816424] Dynamic subtest rcs0: SUCCESS (0.011s)
[456.846722] Starting dynamic subtest: bcs0
[456.848980] Dynamic subtest bcs0: SUCCESS (0.010s)
[456.873899] Starting dynamic subtest: vcs0
[456.875170] Dynamic subtest vcs0: SUCCESS (0.007s)
[456.898283] Starting dynamic subtest: vecs0
[456.899648] Dynamic subtest vecs0: SUCCESS (0.006s)
[456.900945] Subtest timeslicing: SUCCESS (0.047s)
[457.202313] [115/142] (572s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[457.513185] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[457.516105] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[457.618395] [116/142] (572s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[457.927528] Starting subtest: cursorA-vs-flipA-varying-size
[469.222381] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.295s)
[469.577205] [117/142] (560s left) gem_mmap_gtt (basic-small-bo-tiledx)
[469.784578] Starting subtest: basic-small-bo-tiledX
[470.383371] Subtest basic-small-bo-tiledX: SUCCESS (0.599s)
[470.552959] [118/142] (559s left) gem_ctx_persistence (hostile)
[470.885723] Starting subtest: hostile
[472.998367] Subtest hostile: SUCCESS (2.111s)
[473.125194] [119/142] (556s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[473.444683] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[473.447638] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[473.557733] [120/142] (556s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[474.228826] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[474.558844] [121/142] (555s left) gem_exec_params (sol-reset-invalid)
[474.772445] Starting subtest: sol-reset-invalid
[474.777270] Subtest sol-reset-invalid: SUCCESS (0.005s)
[474.890522] [122/142] (555s left) gem_pread (self)
[475.090746] Starting subtest: self
[475.139474] Subtest self: SUCCESS (0.050s)
[475.240886] [123/142] (554s left) gem_mmap (basic)
[475.442527] Starting subtest: basic
[475.449969] Subtest basic: SUCCESS (0.001s)
[475.557425] [124/142] (554s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[475.863288] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[475.866088] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[475.957740] [125/142] (554s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[476.262835] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[476.264627] Starting dynamic subtest: pipe-A-valid-mode
[476.363455] Dynamic subtest pipe-A-valid-mode: SKIP (0.095s)
[476.367200] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.100s)
[476.689413] [126/142] (553s left) kms_plane_scaling (2x-scaler-multi-pipe)
[476.996130] Starting subtest: 2x-scaler-multi-pipe
[477.002520] Subtest 2x-scaler-multi-pipe: SKIP (0.004s)
[477.090360] [127/142] (553s left) gem_exec_fence (submit)
[477.456749] Starting subtest: submit
[477.458479] Starting dynamic subtest: rcs0
[477.482599] Dynamic subtest rcs0: SUCCESS (0.023s)
[477.517316] Starting dynamic subtest: bcs0
[477.518828] Dynamic subtest bcs0: SUCCESS (0.029s)
[477.552432] Starting dynamic subtest: vcs0
[477.554231] Dynamic subtest vcs0: SUCCESS (0.022s)
[477.582104] Starting dynamic subtest: vecs0
[477.583511] Dynamic subtest vecs0: SUCCESS (0.022s)
[477.584882] Subtest submit: SUCCESS (0.109s)
[478.241185] [128/142] (552s left) gem_mmap_offset (blt-coherency)
[478.443727] Starting subtest: blt-coherency
[478.462644] Subtest blt-coherency: SUCCESS (0.020s)
[478.573559] [129/142] (551s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[478.788109] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[478.956822] [130/142] (551s left) gem_exec_params (invalid-batch-start-offset)
[479.165324] Starting subtest: invalid-batch-start-offset
[479.176561] Subtest invalid-batch-start-offset: SUCCESS (0.009s)
[479.289862] [131/142] (551s left) gem_tiled_blits (basic)
[479.738587] Starting subtest: basic
[479.779776] Subtest basic: SUCCESS (0.042s)
[479.913556] [132/142] (550s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_ccs)
[480.455277] Starting subtest: pipe-A-crc-primary-basic-y_tiled_ccs
[481.349746] Subtest pipe-A-crc-primary-basic-y_tiled_ccs: SUCCESS (0.897s)
[482.051255] [133/142] (548s left) vc4/vc4_perfmon (get-values-valid-perfmon)
[482.335757] Subtest get-values-valid-perfmon: SKIP (0.000s)
[482.415202] [134/142] (548s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs)
[482.715636] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs
[482.718289] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[483.407876] [135/142] (547s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[483.613823] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[483.615794] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[483.707724] [136/142] (547s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[484.361450] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[484.367434] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.004s)
[484.688156] [137/142] (546s left) prime_vgem (fence-read-hang)
[484.906907] Subtest fence-read-hang: SKIP (0.000s)
[485.004304] [138/142] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[485.315345] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[485.318674] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[485.437792] [139/142] (545s left) vc4/vc4_mmap (mmap-bad-handle)
[485.692050] Subtest mmap-bad-handle: SKIP (0.000s)
[485.771495] [140/142] (545s left) gem_eio (wait-immediate)
[485.989500] Starting subtest: wait-immediate
[486.056428] Subtest wait-immediate: SUCCESS (0.067s)
[486.271529] [141/142] (544s left) kms_frontbuffer_tracking (psr-1p-rte)
[486.598190] Starting subtest: psr-1p-rte
[486.601065] Subtest psr-1p-rte: SKIP (0.000s)
[486.705297] [142/142] (544s left) gem_userptr_blits (access-control)
[486.975599] Starting subtest: access-control
[486.978827] Subtest access-control: SKIP (0.000s)
[487.068675] Closing watchdogs
Done.