[42.269854] Initializing watchdogs
[42.270081]   /dev/watchdog0
[42.282620] [001/142] (960s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[42.565815] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[44.641026] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (2.082s)
[44.873858] [002/142] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[45.128966] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[45.131277] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[45.213732] [003/142] (957s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[45.457216] Starting subtest: y-tiled-16bpp-rotate-270
[45.764237] Subtest y-tiled-16bpp-rotate-270: SKIP (0.305s)
[45.933751] [004/142] (956s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[46.123979] Subtest bad-multisync-out-sync: SKIP (0.000s)
[46.184735] [005/142] (956s left) gem_lmem_swapping (verify-ccs)
[46.341622] Subtest verify-ccs: SKIP (0.000s)
[46.386345] [006/142] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[46.633377] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[48.623122] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SUCCESS (1.990s)
[48.768079] [007/142] (954s left) gem_mmap_wc (invalid-flags)
[48.916470] Starting subtest: invalid-flags
[48.919107] Subtest invalid-flags: SUCCESS (0.001s)
[49.001993] [008/142] (953s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[49.148530] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[49.150842] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[49.234541] [009/142] (953s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[49.478290] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[51.077076] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SUCCESS (1.595s)
[51.218057] [010/142] (951s left) kms_flip (2x-wf_vblank-ts-check)
[51.433463] Starting subtest: 2x-wf_vblank-ts-check
[51.438157] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[62.650050] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.208s)
[62.671910] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[73.683896] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.015s)
[73.696872] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[84.692193] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (11.014s)
[84.693342] Subtest 2x-wf_vblank-ts-check: SUCCESS (33.260s)
[85.248361] [011/142] (917s left) gem_mmap_wc (write-cpu-read-wc)
[85.396843] Starting subtest: write-cpu-read-wc
[85.550658] Subtest write-cpu-read-wc: SUCCESS (0.152s)
[85.628823] [012/142] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[85.869074] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[85.871415] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[85.951493] [013/142] (917s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[86.648758] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[86.656308] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.007s)
[86.988463] [014/142] (916s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[87.216866] Starting subtest: cursorA-vs-flipA-atomic-transitions
[98.526675] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.310s)
[98.742288] [015/142] (904s left) gem_exec_schedule (semaphore-noskip)
[98.931365] Starting subtest: semaphore-noskip
[99.154754] Subtest semaphore-noskip: SUCCESS (0.224s)
[99.474319] [016/142] (903s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs)
[100.261568] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[100.558313] [017/142] (902s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[100.811714] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[100.814132] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[100.898862] [018/142] (902s left) gem_eio (wait-wedge-immediate)
[101.078817] Starting subtest: wait-wedge-immediate
[101.165314] Subtest wait-wedge-immediate: SUCCESS (0.087s)
[101.341984] [019/142] (901s left) gem_pxp (reject-modify-context-protection-off-1)
[104.004523] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[104.082500] [020/142] (899s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[104.337846] Starting subtest: fbc-rgb565-draw-blt
[106.762805] Subtest fbc-rgb565-draw-blt: SUCCESS (2.425s)
[107.048537] [021/142] (896s left) kms_color (invalid-ctm-matrix-sizes)
[107.285656] Starting subtest: invalid-ctm-matrix-sizes
[107.286795] Starting dynamic subtest: pipe-A
[107.295872] Dynamic subtest pipe-A: SUCCESS (0.012s)
[107.311850] Starting dynamic subtest: pipe-B
[107.315852] Dynamic subtest pipe-B: SUCCESS (0.016s)
[107.332840] Starting dynamic subtest: pipe-C
[107.335965] Dynamic subtest pipe-C: SUCCESS (0.018s)
[107.337187] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.049s)
[107.414727] [022/142] (895s left) i915_pm_freq_mult (media-freq)
[107.561371] Starting subtest: media-freq
[107.563978] Starting dynamic subtest: gt0
[107.566357] Dynamic subtest gt0: SKIP (0.001s)
[107.568957] Subtest media-freq: SKIP (0.004s)
[107.647239] [023/142] (895s left) gem_exec_parallel (fds)
[107.813316] Starting subtest: fds
[107.815961] Starting dynamic subtest: rcs0
[111.970129] Dynamic subtest rcs0: SUCCESS (4.152s)
[111.988287] Starting dynamic subtest: bcs0
[116.431776] Dynamic subtest bcs0: SUCCESS (4.462s)
[116.445050] Starting dynamic subtest: vcs0
[120.514313] Dynamic subtest vcs0: SUCCESS (4.077s)
[120.541209] Starting dynamic subtest: vecs0
[124.595699] Dynamic subtest vecs0: SUCCESS (4.085s)
[124.599461] Subtest fds: SUCCESS (16.784s)
[124.814705] [024/142] (878s left) kms_hdr (static-swap)
[125.062105] Starting subtest: static-swap
[125.065942] Subtest static-swap: SKIP (0.002s)
[125.150492] [025/142] (878s left) gem_userptr_blits (set-cache-level)
[125.315567] Starting subtest: set-cache-level
[125.316776] Subtest set-cache-level: SUCCESS (0.001s)
[125.449223] [026/142] (878s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[125.697356] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[125.700272] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[125.782488] [027/142] (877s left) kms_vblank (pipe-b-wait-idle)
[126.010135] Starting subtest: pipe-B-wait-idle
[131.533609] Subtest pipe-B-wait-idle: SUCCESS (5.523s)
[131.769765] [028/142] (871s left) kms_psr (primary_render)
[131.919455] Subtest primary_render: SKIP (0.000s)
[131.972447] [029/142] (871s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[132.219369] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[132.222283] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[132.303086] [030/142] (871s left) gem_exec_capture (userptr)
[132.454408] Starting subtest: userptr
[133.743015] Subtest userptr: SUCCESS (1.289s)
[133.836424] [031/142] (869s left) kms_vblank (pipe-b-query-forked-hang)
[134.075836] Starting subtest: pipe-B-query-forked-hang
[149.431056] Subtest pipe-B-query-forked-hang: SUCCESS (15.356s)
[149.707605] [032/142] (853s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[149.945370] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[149.949601] Starting dynamic subtest: pipe-A-valid-mode
[150.694273] Dynamic subtest pipe-A-valid-mode: SKIP (0.742s)
[150.698603] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.747s)
[151.177674] [033/142] (852s left) kms_chamelium_hpd (vga-hpd-fast)
[151.861243] Subtest vga-hpd-fast: SKIP (0.000s)
[152.155870] [034/142] (851s left) kms_psr2_sf (cursor-plane-update-sf)
[152.302446] Subtest cursor-plane-update-sf: SKIP (0.000s)
[152.357679] [035/142] (851s left) gem_create (create-ext-placement-each)
[152.626689] Starting subtest: create-ext-placement-each
[152.627846] Subtest create-ext-placement-each: SUCCESS (0.001s)
[152.711832] [036/142] (851s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_mc_ccs)
[153.451203] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_mc_ccs
[153.455270] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.003s)
[153.903474] [037/142] (849s left) perf_pmu (interrupts-sync)
[154.056719] Starting subtest: interrupts-sync
[155.198793] Subtest interrupts-sync: SUCCESS (1.140s)
[155.289056] [038/142] (848s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[155.524856] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[155.527112] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[156.351799] [039/142] (847s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[157.088539] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[157.092508] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.003s)
[157.429870] [040/142] (846s left) gem_exec_schedule (implicit-read-write)
[157.601099] Starting subtest: implicit-read-write
[157.603893] Starting dynamic subtest: rcs0
[157.704836] Dynamic subtest rcs0: SUCCESS (0.100s)
[157.726160] Starting dynamic subtest: bcs0
[157.842899] Dynamic subtest bcs0: SUCCESS (0.137s)
[157.864910] Starting dynamic subtest: vcs0
[157.978401] Dynamic subtest vcs0: SUCCESS (0.130s)
[158.003854] Starting dynamic subtest: vecs0
[158.094432] Dynamic subtest vecs0: SUCCESS (0.109s)
[158.095784] Subtest implicit-read-write: SUCCESS (0.494s)
[158.430602] [041/142] (845s left) kms_cursor_legacy (torture-bo)
[158.676250] Starting subtest: torture-bo
[158.679711] Starting dynamic subtest: pipe-A
[165.605376] Dynamic subtest pipe-A: SUCCESS (6.924s)
[165.625945] Starting dynamic subtest: pipe-B
[171.139339] Dynamic subtest pipe-B: SUCCESS (5.531s)
[171.162025] Starting dynamic subtest: pipe-C
[176.804976] Dynamic subtest pipe-C: SUCCESS (5.663s)
[176.825042] Starting dynamic subtest: all-pipes
[182.624131] Dynamic subtest all-pipes: SUCCESS (5.818s)
[182.625222] Subtest torture-bo: SUCCESS (23.945s)
[182.713812] [042/142] (821s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted)
[182.859217] Starting subtest: invalid-multi-wait-all-available-unsubmitted
[182.860371] Subtest invalid-multi-wait-all-available-unsubmitted: SUCCESS (0.000s)
[182.946260] [043/142] (820s left) gem_basic (multigpu-create-close)
[183.095575] Starting subtest: multigpu-create-close
[183.098168] Subtest multigpu-create-close: SKIP (0.000s)
[183.179101] [044/142] (820s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[183.340192] Starting subtest: yf-tiled-ccs-to-yf-tiled
[183.341311] Starting dynamic subtest: smem
[183.695838] Dynamic subtest smem: SUCCESS (0.353s)
[183.697167] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.355s)
[183.886987] [045/142] (820s left) i915_pm_rpm (legacy-planes)
[185.948420] Starting subtest: legacy-planes
[185.950469] Starting dynamic subtest: plane-40
[189.146571] Dynamic subtest plane-40: SUCCESS (3.194s)
[189.173297] Starting dynamic subtest: plane-48
[191.794359] Dynamic subtest plane-48: SUCCESS (2.645s)
[191.818452] Starting dynamic subtest: plane-56
[194.634520] Dynamic subtest plane-56: SUCCESS (2.837s)
[194.636517] Subtest legacy-planes: SUCCESS (8.683s)
[195.131174] [046/142] (808s left) syncobj_timeline (wait-all-for-submit-complex)
[195.282869] Starting subtest: wait-all-for-submit-complex
[195.499572] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[195.586204] [047/142] (808s left) gem_wait (busy)
[195.764854] Starting subtest: busy
[195.768140] Starting dynamic subtest: all-engines
[196.287225] Dynamic subtest all-engines: SUCCESS (0.520s)
[196.311887] Starting dynamic subtest: rcs0
[196.815213] Dynamic subtest rcs0: SUCCESS (0.516s)
[196.839043] Starting dynamic subtest: bcs0
[197.342223] Dynamic subtest bcs0: SUCCESS (0.524s)
[197.366867] Starting dynamic subtest: vcs0
[197.868171] Dynamic subtest vcs0: SUCCESS (0.516s)
[197.892795] Starting dynamic subtest: vecs0
[198.394190] Dynamic subtest vecs0: SUCCESS (0.513s)
[198.395921] Subtest busy: SUCCESS (2.631s)
[198.621994] [048/142] (805s left) gem_exec_flush (basic-batch-kernel-default-wb)
[198.794070] Starting subtest: basic-batch-kernel-default-wb
[204.388849] Subtest basic-batch-kernel-default-wb: SUCCESS (5.589s)
[204.587191] [049/142] (799s left) gem_create (create-valid-nonaligned)
[204.730898] Starting subtest: create-valid-nonaligned
[204.732164] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[204.937100] [050/142] (799s left) i915_query (query-regions-unallocated)
[205.084731] Starting subtest: query-regions-unallocated
[205.085861] Subtest query-regions-unallocated: SUCCESS (0.000s)
[205.169683] [051/142] (799s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[205.419851] Starting subtest: cursor-rapid-movement-64x64
[205.504836] Starting dynamic subtest: pipe-A-HDMI-A-1
[206.437164] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.934s)
[206.585057] Starting dynamic subtest: pipe-C-HDMI-A-1
[208.046086] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.486s)
[208.047901] Subtest cursor-rapid-movement-64x64: SUCCESS (2.626s)
[208.408063] [052/142] (795s left) gem_exec_reloc (basic-cpu-gtt)
[208.568586] Starting subtest: basic-cpu-gtt
[208.591334] Subtest basic-cpu-gtt: SUCCESS (0.023s)
[208.778955] [053/142] (795s left) gem_exec_reloc (basic-wc-cpu)
[208.940760] Starting subtest: basic-wc-cpu
[208.959293] Subtest basic-wc-cpu: SUCCESS (0.019s)
[209.147509] [054/142] (795s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[209.298086] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[209.301210] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.002s)
[209.396542] [055/142] (794s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[209.655138] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[209.657307] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[209.745587] [056/142] (794s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[210.005411] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[212.174818] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.173s)
[212.327215] [057/142] (792s left) kms_big_fb (linear-8bpp-rotate-0)
[212.583535] Starting subtest: linear-8bpp-rotate-0
[216.306817] Subtest linear-8bpp-rotate-0: SUCCESS (3.723s)
[216.595381] [058/142] (787s left) kms_rotation_crc (sprite-rotation-270)
[216.835691] Starting subtest: sprite-rotation-270
[229.089611] Subtest sprite-rotation-270: SUCCESS (12.253s)
[229.304159] [059/142] (775s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[229.556210] Starting subtest: basic-busy-flip-before-cursor-atomic
[229.558535] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.001s)
[229.655443] [060/142] (774s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[229.820092] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[229.822290] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[230.022260] [061/142] (774s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[230.174260] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[230.285315] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.109s)
[230.371296] [062/142] (774s left) gem_exec_big (single)
[230.524315] Starting subtest: single
[246.289547] Subtest single: SUCCESS (15.758s)
[246.884178] [063/142] (757s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[247.277241] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[247.283586] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[247.376290] [064/142] (757s left) perf (non-zero-reason)
[247.686384] Starting subtest: non-zero-reason
[247.689970] Starting dynamic subtest: 0-rcs0
[306.696065] Dynamic subtest 0-rcs0: SUCCESS (59.004s)
[306.697934] Subtest non-zero-reason: SUCCESS (59.008s)
[306.739241] [065/142] (697s left) kms_rotation_crc (sprite-rotation-180)
[306.976784] Starting subtest: sprite-rotation-180
[316.109375] Subtest sprite-rotation-180: SUCCESS (9.135s)
[316.341288] [066/142] (688s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[316.590269] Starting subtest: cursorB-vs-flipA-toggle
[328.144569] Subtest cursorB-vs-flipA-toggle: SUCCESS (11.548s)
[328.503095] [067/142] (676s left) api_intel_allocator (standalone)
[328.658384] Starting subtest: standalone
[328.717247] Subtest standalone: SUCCESS (0.057s)
[328.806665] [068/142] (675s left) kms_psr (psr2_sprite_mmap_cpu)
[328.951238] Subtest psr2_sprite_mmap_cpu: SKIP (0.000s)
[329.003139] [069/142] (675s left) vgem_basic (bad-fence)
[329.157206] Starting subtest: bad-fence
[329.158299] Subtest bad-fence: SUCCESS (0.000s)
[329.233681] [070/142] (675s left) gem_huc_copy (huc-copy)
[329.393465] Starting subtest: huc-copy
[329.395690] Subtest huc-copy: SKIP (0.000s)
[329.488828] [071/142] (675s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[329.638076] Starting subtest: invalid-smem-bo-on-discrete
[329.640430] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[329.839219] [072/142] (674s left) syncobj_timeline (invalid-query-bad-pad)
[329.994402] Starting subtest: invalid-query-bad-pad
[329.995682] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[330.088795] [073/142] (674s left) kms_chamelium_color (gamma)
[330.331874] Subtest gamma: SKIP (0.000s)
[330.391632] [074/142] (674s left) kms_plane (plane-position-hole)
[330.640395] Starting subtest: plane-position-hole
[330.643743] Starting dynamic subtest: pipe-A-planes
[333.413972] Dynamic subtest pipe-A-planes: SUCCESS (2.770s)
[333.444323] Starting dynamic subtest: pipe-B-planes
[336.429942] Dynamic subtest pipe-B-planes: SUCCESS (3.001s)
[336.431891] Subtest plane-position-hole: SUCCESS (5.795s)
[336.800696] [075/142] (668s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs)
[337.539125] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs
[337.542530] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[337.916230] [076/142] (667s left) i915_hwmon (hwmon-write)
[338.063095] Subtest hwmon-write: SKIP (0.000s)
[338.118979] [077/142] (666s left) kms_chamelium_frames (hdmi-crc-fast)
[338.778228] Subtest hdmi-crc-fast: SKIP (0.000s)
[339.053394] [078/142] (665s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[339.296391] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[339.301397] Starting dynamic subtest: pipe-A-valid-mode
[340.309494] Dynamic subtest pipe-A-valid-mode: SKIP (1.002s)
[340.311738] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.009s)
[340.812434] [079/142] (664s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[341.075528] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[341.354278] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.272s)
[341.582302] [080/142] (663s left) syncobj_wait (signal)
[341.736228] Starting subtest: signal
[341.739356] Subtest signal: SUCCESS (0.003s)
[341.832752] [081/142] (663s left) kms_addfb_basic (unused-offsets)
[341.986340] Starting subtest: unused-offsets
[341.987475] Subtest unused-offsets: SUCCESS (0.000s)
[342.181987] [082/142] (662s left) syncobj_wait (wait-all-for-submit-complex)
[342.333911] Starting subtest: wait-all-for-submit-complex
[342.552234] Subtest wait-all-for-submit-complex: SUCCESS (0.218s)
[342.648636] [083/142] (662s left) kms_big_fb (y-tiled-addfb-size-overflow)
[342.914394] Starting subtest: y-tiled-addfb-size-overflow
[342.922615] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.008s)
[343.031083] [084/142] (662s left) drm_fdinfo (virtual-busy-idle-all)
[343.234622] Starting subtest: virtual-busy-idle-all
[343.238874] Subtest virtual-busy-idle-all: SUCCESS (0.004s)
[343.349815] [085/142] (661s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_ccs)
[344.206352] Starting subtest: pipe-B-bad-pixel-format-y_tiled_ccs
[344.210331] Subtest pipe-B-bad-pixel-format-y_tiled_ccs: SUCCESS (0.003s)
[344.578313] [086/142] (660s left) kms_vblank (pipe-d-wait-idle-hang)
[344.822786] Subtest pipe-D-wait-idle-hang: SKIP (0.000s)
[344.912331] [087/142] (660s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_ccs)
[345.724154] Starting subtest: pipe-C-random-ccs-data-y_tiled_ccs
[345.727474] Subtest pipe-C-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[346.037270] [088/142] (659s left) gem_ctx_persistence (idempotent)
[346.193251] Starting subtest: idempotent
[346.194384] Subtest idempotent: SUCCESS (0.000s)
[346.294913] [089/142] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[346.558562] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[346.560842] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[346.644985] [090/142] (658s left) v3d/v3d_submit_csd (multiple-job-submission)
[346.839232] Subtest multiple-job-submission: SKIP (0.000s)
[346.904467] [091/142] (658s left) kms_lease (atomic_implicit_crtc)
[347.149774] Starting subtest: atomic_implicit_crtc
[347.156276] Starting dynamic subtest: pipe-A-HDMI-A-1
[347.162143] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.007s)
[347.202611] Starting dynamic subtest: pipe-A-HDMI-A-2
[347.238232] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.057s)
[347.271412] Starting dynamic subtest: pipe-B-HDMI-A-1
[347.296791] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.048s)
[347.339234] Starting dynamic subtest: pipe-B-HDMI-A-2
[347.341367] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.015s)
[347.377410] Starting dynamic subtest: pipe-C-HDMI-A-1
[347.379589] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.031s)
[347.411637] Starting dynamic subtest: pipe-C-HDMI-A-2
[347.412876] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.034s)
[347.414159] Subtest atomic_implicit_crtc: SUCCESS (0.251s)
[347.487753] [092/142] (657s left) kms_universal_plane (cursor-fb-leak-pipe-c)
[347.737760] Starting subtest: cursor-fb-leak-pipe-C
[350.057219] Subtest cursor-fb-leak-pipe-C: SUCCESS (2.322s)
[350.415992] [093/142] (655s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[350.645033] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[350.650773] Starting dynamic subtest: pipe-A-HDMI-A-1
[350.990073] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.331s)
[351.019613] Starting dynamic subtest: pipe-B-HDMI-A-1
[351.417137] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.427s)
[351.449859] Starting dynamic subtest: pipe-C-HDMI-A-1
[351.565495] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.136s)
[351.566735] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.920s)
[352.010889] [094/142] (653s left) kms_vblank (pipe-c-query-forked-busy-hang)
[352.252509] Starting subtest: pipe-C-query-forked-busy-hang
[368.453950] Subtest pipe-C-query-forked-busy-hang: SUCCESS (16.206s)
[368.778669] [095/142] (636s left) gem_mmap_wc (write-wc-read-gtt)
[368.927578] Starting subtest: write-wc-read-gtt
[369.413210] Subtest write-wc-read-gtt: SUCCESS (0.483s)
[369.511054] [096/142] (636s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[369.778599] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[369.780981] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[369.878340] [097/142] (635s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[370.719475] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[371.047925] [098/142] (634s left) gem_ppgtt (blt-vs-render-ctx0)
[371.202890] Starting subtest: blt-vs-render-ctx0
[403.977919] Subtest blt-vs-render-ctx0: SUCCESS (32.773s)
[404.075555] [099/142] (601s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[404.430049] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[407.016880] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.588s)
[407.321085] [100/142] (598s left) kms_dsc (dsc-with-formats)
[407.567520] Subtest dsc-with-formats: SKIP (0.000s)
[407.625393] [101/142] (598s left) gem_exec_schedule (preempt-queue-contexts-chain)
[407.821666] Starting subtest: preempt-queue-contexts-chain
[407.822809] Starting dynamic subtest: rcs0
[408.473368] Dynamic subtest rcs0: SUCCESS (0.646s)
[408.501800] Starting dynamic subtest: bcs0
[409.051904] Dynamic subtest bcs0: SUCCESS (0.579s)
[409.080096] Starting dynamic subtest: vcs0
[409.635894] Dynamic subtest vcs0: SUCCESS (0.581s)
[409.657910] Starting dynamic subtest: vecs0
[410.238190] Dynamic subtest vecs0: SUCCESS (0.593s)
[410.239971] Subtest preempt-queue-contexts-chain: SUCCESS (2.421s)
[410.586247] [102/142] (595s left) prime_self_import (basic-with_one_bo_two_files)
[410.730308] Starting subtest: basic-with_one_bo_two_files
[410.733297] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[410.822490] [103/142] (595s left) gem_exec_fair (basic-pace-solo)
[410.991239] Starting subtest: basic-pace-solo
[410.992845] Starting dynamic subtest: rcs0
[415.925364] Dynamic subtest rcs0: FAIL (4.902s)
[415.926658] Subtest basic-pace-solo: FAIL (4.905s)
[416.091413] [104/142] (589s left) kms_busy (extended-pageflip-hang-oldfb)
[416.335796] Starting subtest: extended-pageflip-hang-oldfb
[416.341222] Starting dynamic subtest: pipe-A
[417.212570] Dynamic subtest pipe-A: SUCCESS (0.865s)
[417.238836] Starting dynamic subtest: pipe-C
[417.750862] Dynamic subtest pipe-C: SUCCESS (0.529s)
[417.755621] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.421s)
[418.124876] [105/142] (587s left) kms_vblank (pipe-d-query-forked-hang)
[418.366634] Subtest pipe-D-query-forked-hang: SKIP (0.000s)
[418.457330] [106/142] (587s left) kms_pipe_crc_basic (hang-read-crc)
[418.694183] Starting subtest: hang-read-crc
[418.699492] Starting dynamic subtest: pipe-A-HDMI-A-1
[420.488274] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.788s)
[420.521313] Starting dynamic subtest: pipe-B-HDMI-A-2
[422.827622] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.331s)
[422.857212] Starting dynamic subtest: pipe-C-HDMI-A-1
[425.555384] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.710s)
[425.556538] Subtest hang-read-crc: SUCCESS (6.861s)
[425.812255] [107/142] (580s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[425.973992] Starting subtest: basic-wc-gtt-noreloc
[425.986892] Subtest basic-wc-gtt-noreloc: SUCCESS (0.013s)
[426.178594] [108/142] (579s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[426.434461] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[426.436873] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[426.528798] [109/142] (579s left) gem_ctx_engines (independent)
[426.695177] Starting subtest: independent
[426.698351] Starting dynamic subtest: rcs0
[426.896317] Dynamic subtest rcs0: SUCCESS (0.197s)
[426.921849] Starting dynamic subtest: bcs0
[427.150631] Dynamic subtest bcs0: SUCCESS (0.251s)
[427.188890] Starting dynamic subtest: vcs0
[427.350341] Dynamic subtest vcs0: SUCCESS (0.182s)
[427.386878] Starting dynamic subtest: vecs0
[427.548538] Dynamic subtest vecs0: SUCCESS (0.182s)
[427.574856] Starting dynamic subtest: all-engines
[428.200356] Dynamic subtest all-engines: SUCCESS (0.649s)
[428.201542] Subtest independent: SUCCESS (1.505s)
[428.412666] [110/142] (577s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[428.660187] Starting subtest: cursorB-vs-flipB-varying-size
[440.025799] Subtest cursorB-vs-flipB-varying-size: SUCCESS (11.365s)
[440.387724] [111/142] (565s left) kms_scaling_modes (scaling-mode-full)
[440.644756] Starting subtest: scaling-mode-full
[440.648269] Subtest scaling-mode-full: SKIP (0.005s)
[440.741985] [112/142] (565s left) i915_getparams_basic (basic-eu-total)
[440.891840] Starting subtest: basic-eu-total
[440.894126] Subtest basic-eu-total: SUCCESS (0.000s)
[440.984944] [113/142] (565s left) gem_caching (read-writes)
[441.142484] Starting subtest: read-writes
[466.168726] Subtest read-writes: SUCCESS (25.026s)
[466.292767] [114/142] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[466.550488] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[469.052789] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.501s)
[469.221736] [115/142] (536s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[469.478781] Starting subtest: 4-tiled-32bpp-rotate-270
[469.481174] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[469.571663] [116/142] (536s left) vc4/vc4_purgeable_bo (mark-purgeable-twice)
[469.771951] Subtest mark-purgeable-twice: SKIP (0.000s)
[469.839278] [117/142] (536s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs)
[470.525439] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs
[470.528966] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[470.910626] [118/142] (535s left) gem_mmap_wc (read-write)
[471.060296] Starting subtest: read-write
[471.072526] Subtest read-write: SUCCESS (0.012s)
[471.164760] [119/142] (535s left) gem_exec_balancer (bonded-false-hang)
[474.223072] Starting subtest: bonded-false-hang
[476.903806] Subtest bonded-false-hang: SUCCESS (2.681s)
[476.999571] [120/142] (529s left) v3d/v3d_create_bo (create-bo-4096)
[477.196219] Subtest create-bo-4096: SKIP (0.000s)
[477.266580] [121/142] (529s left) gem_partial_pwrite_pread (reads-snoop)
[477.414654] Starting subtest: reads-snoop
[482.257400] Subtest reads-snoop: SUCCESS (4.843s)
[482.358976] [122/142] (524s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[482.630375] Starting subtest: fbcpsr-modesetfrombusy
[482.632685] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[482.725915] [123/142] (523s left) gem_exec_whisper (basic-contexts-all)
[482.886564] Starting subtest: basic-contexts-all
[498.130507] Subtest basic-contexts-all: SUCCESS (15.242s)
[498.351778] [124/142] (508s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[499.196323] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[499.527313] [125/142] (507s left) kms_ccs (pipe-c-crc-primary-basic-yf_tiled_ccs)
[500.325866] Starting subtest: pipe-C-crc-primary-basic-yf_tiled_ccs
[500.330260] Subtest pipe-C-crc-primary-basic-yf_tiled_ccs: SKIP (0.003s)
[500.720626] [126/142] (505s left) kms_universal_plane (cursor-fb-leak-pipe-a)
[500.960852] Starting subtest: cursor-fb-leak-pipe-A
[502.330446] Subtest cursor-fb-leak-pipe-A: SUCCESS (1.370s)
[502.679953] [127/142] (503s left) perf_pmu (all-busy-idle-check-all)
[502.831848] Starting subtest: all-busy-idle-check-all
[503.449308] Subtest all-busy-idle-check-all: SUCCESS (0.617s)
[503.546230] [128/142] (503s left) core_setmaster (master-drop-set-root)
[504.960287] Starting subtest: master-drop-set-root
[504.978704] Subtest master-drop-set-root: SUCCESS (0.018s)
[505.016998] [129/142] (501s left) kms_cursor_crc (cursor-random-256x85)
[505.294192] Starting subtest: cursor-random-256x85
[505.333977] Starting dynamic subtest: pipe-A-HDMI-A-1
[509.522629] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.185s)
[509.674816] Starting dynamic subtest: pipe-C-HDMI-A-1
[513.849264] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (4.191s)
[513.850584] Subtest cursor-random-256x85: SUCCESS (8.551s)
[514.199315] [130/142] (492s left) perf_pmu (module-unload)
[514.380530] Starting subtest: module-unload
[552.644381] Subtest module-unload: SUCCESS (38.263s)
[552.674588] [131/142] (454s left) gem_ctx_persistence (userptr)
[554.053611] Starting subtest: userptr
[554.356559] Subtest userptr: SUCCESS (0.299s)
[554.472658] [132/142] (452s left) gem_exec_fence (syncobj-timeline-unused-fence)
[555.448549] Starting subtest: syncobj-timeline-unused-fence
[555.453569] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[555.671514] [133/142] (451s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[555.910823] Starting subtest: primary-y-tiled-reflect-x-90
[555.914979] Subtest primary-y-tiled-reflect-x-90: SKIP (0.005s)
[556.008660] [134/142] (450s left) kms_plane (pixel-format)
[556.250334] Starting subtest: pixel-format
[556.256254] Starting dynamic subtest: pipe-A-planes
[572.705959] Dynamic subtest pipe-A-planes: SUCCESS (16.450s)
[572.737405] Starting dynamic subtest: pipe-B-planes
[588.711231] Dynamic subtest pipe-B-planes: SUCCESS (15.982s)
[588.712357] Subtest pixel-format: SUCCESS (32.457s)
[588.997909] [135/142] (417s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_ccs)
[589.795244] Starting subtest: pipe-C-bad-rotation-90-y_tiled_ccs
[589.797515] Subtest pipe-C-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[590.133703] [136/142] (416s left) syncobj_wait (multi-wait-for-submit-submitted)
[590.283221] Starting subtest: multi-wait-for-submit-submitted
[590.388311] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[590.473071] [137/142] (416s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[590.739341] Starting subtest: psr-rgb565-draw-render
[590.741755] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[590.833776] [138/142] (416s left) v3d/v3d_submit_csd (valid-submission)
[591.034869] Subtest valid-submission: SKIP (0.000s)
[591.106630] [139/142] (415s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[591.363342] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[591.365584] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[591.456942] [140/142] (415s left) kms_frontbuffer_tracking (fbc-1p-rte)
[591.722569] Starting subtest: fbc-1p-rte
[596.315876] Subtest fbc-1p-rte: SUCCESS (4.594s)
[596.568590] [141/142] (410s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[596.825364] Starting subtest: x-tiled-8bpp-rotate-90
[597.214136] Subtest x-tiled-8bpp-rotate-90: SKIP (0.383s)
[597.437465] [142/142] (409s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[598.266897] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[598.270321] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[598.641446] Closing watchdogs
Done.