[51.837573] Initializing watchdogs
[51.838127]   /dev/watchdog0
[51.871102] [001/142] (960s left) gem_workarounds (suspend-resume-context)
[52.390464] Starting subtest: suspend-resume-context
[69.217776] Subtest suspend-resume-context: SUCCESS (16.827s)
[69.415606] [002/142] (943s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[69.952148] Starting subtest: basic-busy-flip-before-cursor-varying-size
[69.959793] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[70.249687] [003/142] (942s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[70.743916] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[70.750795] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[70.906810] [004/142] (941s left) kms_color (ctm-0-75)
[71.387953] Starting subtest: ctm-0-75
[71.391285] Starting dynamic subtest: pipe-A
[78.779804] Dynamic subtest pipe-A: SUCCESS (7.388s)
[78.812880] Starting dynamic subtest: pipe-B
[86.344507] Dynamic subtest pipe-B: SUCCESS (7.569s)
[86.390779] Starting dynamic subtest: pipe-C
[94.076249] Dynamic subtest pipe-C: SUCCESS (7.728s)
[94.108636] Starting dynamic subtest: pipe-D
[102.363969] Dynamic subtest pipe-D: SUCCESS (8.289s)
[102.367560] Subtest ctm-0-75: SUCCESS (30.977s)
[103.305719] [005/142] (909s left) syncobj_timeline (multi-wait-all-available-signaled)
[103.685858] Starting subtest: multi-wait-all-available-signaled
[103.689597] Subtest multi-wait-all-available-signaled: SUCCESS (0.003s)
[103.824994] [006/142] (908s left) gem_userptr_blits (create-destroy-sync)
[104.284892] Starting subtest: create-destroy-sync
[109.383239] Subtest create-destroy-sync: SUCCESS (5.099s)
[109.629960] [007/142] (903s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[110.121798] Starting subtest: addfb25-y-tiled-legacy
[110.125472] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[110.278811] [008/142] (902s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[110.656054] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[110.758174] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[110.890314] [009/142] (902s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[111.333657] Starting subtest: map-fixed-invalidate-overlap
[111.340500] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[111.543733] [010/142] (901s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[112.080390] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[112.087358] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[112.242213] [011/142] (900s left) gem_exec_whisper (basic-contexts-all)
[112.662384] Starting subtest: basic-contexts-all
[134.566513] Subtest basic-contexts-all: SUCCESS (21.899s)
[134.917121] [012/142] (878s left) perf (low-oa-exponent-permissions)
[135.829784] Starting subtest: low-oa-exponent-permissions
[136.065897] Subtest low-oa-exponent-permissions: SUCCESS (0.241s)
[136.172109] [013/142] (877s left) kms_pwrite_crc
[139.235943] [014/142] (874s left) gem_exec_schedule (u-semaphore-user)
[139.683432] Starting subtest: u-semaphore-user
[139.733923] Subtest u-semaphore-user: SUCCESS (0.049s)
[141.714971] [015/142] (871s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[142.222846] Starting subtest: fbc-tiling-linear
[148.370487] Subtest fbc-tiling-linear: SUCCESS (6.146s)
[148.609381] [016/142] (864s left) syncobj_wait (wait-all-for-submit-snapshot)
[148.985979] Starting subtest: wait-all-for-submit-snapshot
[149.070799] Subtest wait-all-for-submit-snapshot: SUCCESS (0.084s)
[149.214512] [017/142] (864s left) kms_plane_scaling (2x-scaler-multi-pipe)
[149.693564] Starting subtest: 2x-scaler-multi-pipe
[149.709066] Subtest 2x-scaler-multi-pipe: SKIP (0.015s)
[149.845964] [018/142] (863s left) gem_softpin (noreloc-interruptible)
[150.238942] Starting subtest: noreloc-interruptible
[155.806934] Subtest noreloc-interruptible: SUCCESS (5.565s)
[156.049449] [019/142] (857s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[156.438098] Starting subtest: single-wait-for-submit-available-signaled
[156.442189] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.002s)
[156.610802] [020/142] (857s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[157.712502] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[157.719609] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.002s)
[158.769949] [021/142] (855s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[160.895336] Starting subtest: syncobj-backward-timeline-chain-engines
[161.246114] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.350s)
[161.702238] [022/142] (852s left) i915_query (engine-info)
[162.078358] Starting subtest: engine-info
[162.088266] Subtest engine-info: SUCCESS (0.012s)
[162.285694] [023/142] (851s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[163.527869] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[163.534356] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[164.609687] [024/142] (849s left) i915_pm_rpm (gem-mmap-type)
[170.831944] Starting subtest: gem-mmap-type
[170.836697] Starting dynamic subtest: gtt-smem0
[171.564130] Dynamic subtest gtt-smem0: SKIP (0.727s)
[171.607270] Starting dynamic subtest: wb-smem0
[174.674583] Dynamic subtest wb-smem0: SUCCESS (3.111s)
[174.714257] Starting dynamic subtest: wc-smem0
[181.478196] Dynamic subtest wc-smem0: SUCCESS (6.805s)
[181.515576] Starting dynamic subtest: uc-smem0
[188.241327] Dynamic subtest uc-smem0: SUCCESS (6.761s)
[188.244905] Subtest gem-mmap-type: SUCCESS (17.412s)
[188.403501] [025/142] (825s left) drm_fdinfo (virtual-idle)
[188.809416] Starting subtest: virtual-idle
[191.883339] Subtest virtual-idle: SUCCESS (3.073s)
[192.052918] [026/142] (822s left) kms_mmap_write_crc (main)
[192.572343] Starting subtest: main
[192.582250] Starting dynamic subtest: pipe-A-eDP-1
[202.397833] Dynamic subtest pipe-A-eDP-1: SUCCESS (9.818s)
[202.401240] Subtest main: SUCCESS (9.826s)
[203.368380] [027/142] (811s left) kms_universal_plane (cursor-fb-leak-pipe-a)
[203.850242] Starting subtest: cursor-fb-leak-pipe-A
[204.965961] Subtest cursor-fb-leak-pipe-A: SUCCESS (1.119s)
[205.905832] [028/142] (808s left) kms_flip (flip-vs-blocking-wf-vblank)
[206.290498] Starting subtest: flip-vs-blocking-wf-vblank
[206.318203] Starting dynamic subtest: A-eDP1
[215.829141] Dynamic subtest A-eDP1: SUCCESS (9.511s)
[215.868128] Starting dynamic subtest: B-eDP1
[225.147322] Dynamic subtest B-eDP1: SUCCESS (9.314s)
[225.194440] Starting dynamic subtest: C-eDP1
[234.456130] Dynamic subtest C-eDP1: SUCCESS (9.299s)
[234.494458] Starting dynamic subtest: D-eDP1
[243.759439] Dynamic subtest D-eDP1: SUCCESS (9.302s)
[243.784472] Subtest flip-vs-blocking-wf-vblank: SUCCESS (37.497s)
[245.392263] [029/142] (769s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[246.826372] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[246.836103] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[247.755174] [030/142] (766s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[249.385355] Starting subtest: pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[249.392056] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[250.169321] [031/142] (764s left) gem_bad_reloc (negative-reloc-lut)
[250.567540] Subtest negative-reloc-lut: SKIP (0.000s)
[250.698444] [032/142] (764s left) i915_pm_rpm (basic-pci-d3-state)
[256.790500] Starting subtest: basic-pci-d3-state
[261.543718] Subtest basic-pci-d3-state: SUCCESS (4.751s)
[261.751069] [033/142] (753s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[262.844326] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[265.234214] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SUCCESS (2.380s)
[266.450637] [034/142] (748s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[266.867746] Starting subtest: 2x-plain-flip-ts-check-interruptible
[267.033517] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.162s)
[267.208280] [035/142] (747s left) gem_exec_params (no-vebox)
[267.598281] Starting subtest: no-vebox
[267.607371] Subtest no-vebox: SUCCESS (0.007s)
[269.672150] [036/142] (745s left) kms_vblank (pipe-a-ts-continuation-modeset-hang)
[270.152796] Starting subtest: pipe-A-ts-continuation-modeset-hang
[284.879629] Subtest pipe-A-ts-continuation-modeset-hang: SUCCESS (14.722s)
[285.828091] [037/142] (729s left) gem_busy (semaphore)
[286.425980] Subtest semaphore: SKIP (0.000s)
[286.735342] [038/142] (728s left) gem_flink_basic (double-flink)
[287.099322] Starting subtest: double-flink
[287.102871] Subtest double-flink: SUCCESS (0.000s)
[287.279375] [039/142] (728s left) gem_ppgtt (shrink-vs-evict-pinned)
[287.669770] Starting subtest: shrink-vs-evict-pinned
[295.625934] Subtest shrink-vs-evict-pinned: SUCCESS (7.954s)
[295.801766] [040/142] (719s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[296.300753] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[296.307838] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[296.487856] [041/142] (719s left) kms_color (ctm-signed)
[296.961313] Starting subtest: ctm-signed
[296.964700] Starting dynamic subtest: pipe-A
[300.092100] Dynamic subtest pipe-A: SUCCESS (3.127s)
[300.135229] Starting dynamic subtest: pipe-B
[303.937431] Dynamic subtest pipe-B: SUCCESS (3.845s)
[303.980207] Starting dynamic subtest: pipe-C
[307.974192] Dynamic subtest pipe-C: SUCCESS (4.029s)
[308.018158] Starting dynamic subtest: pipe-D
[312.396542] Dynamic subtest pipe-D: SUCCESS (4.420s)
[312.400333] Subtest ctm-signed: SUCCESS (15.437s)
[313.351988] [042/142] (702s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[314.321499] Starting subtest: cursor-rapid-movement-128x42
[314.352401] Starting dynamic subtest: pipe-A-eDP-1
[315.655748] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.301s)
[315.851962] Starting dynamic subtest: pipe-D-eDP-1
[318.508486] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.696s)
[318.512103] Subtest cursor-rapid-movement-128x42: SUCCESS (4.189s)
[319.526464] [043/142] (696s left) v3d/v3d_submit_csd (valid-multisync-submission)
[320.006989] Subtest valid-multisync-submission: SKIP (0.000s)
[320.131436] [044/142] (695s left) kms_plane_alpha_blend (alpha-transparent-fb)
[320.609271] Starting subtest: alpha-transparent-fb
[322.321955] Starting dynamic subtest: pipe-A-eDP-1
[323.656133] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.331s)
[323.710259] Starting dynamic subtest: pipe-D-eDP-1
[325.831915] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.166s)
[325.835412] Subtest alpha-transparent-fb: SUCCESS (5.226s)
[326.811812] [045/142] (689s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[327.195569] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[327.303632] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[327.464488] [046/142] (688s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_mc_ccs)
[328.758429] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs
[328.765490] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[329.399675] [047/142] (686s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_ccs)
[331.065622] Starting subtest: pipe-D-crc-primary-basic-y_tiled_ccs
[331.072521] Subtest pipe-D-crc-primary-basic-y_tiled_ccs: SKIP (0.002s)
[331.829620] [048/142] (684s left) gem_spin_batch (user-each)
[332.259298] Starting subtest: user-each
[335.707475] Subtest user-each: SUCCESS (3.448s)
[337.724987] [049/142] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[338.253972] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[350.762100] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (12.508s)
[351.026362] [050/142] (665s left) kms_vblank (pipe-d-ts-continuation-modeset)
[351.506582] Starting subtest: pipe-D-ts-continuation-modeset
[355.271513] Subtest pipe-D-ts-continuation-modeset: SUCCESS (3.768s)
[356.231201] [051/142] (660s left) gem_ctx_persistence (engines-mixed-process)
[356.628527] Starting subtest: engines-mixed-process
[356.632345] Starting dynamic subtest: rcs0
[358.596437] Dynamic subtest rcs0: SUCCESS (1.959s)
[358.646779] Starting dynamic subtest: bcs0
[360.567577] Dynamic subtest bcs0: SUCCESS (1.972s)
[360.620077] Starting dynamic subtest: vcs0
[380.673546] Dynamic subtest vcs0: SUCCESS (20.103s)
[380.744618] Starting dynamic subtest: vcs1
[400.790396] Dynamic subtest vcs1: SUCCESS (20.110s)
[400.849174] Starting dynamic subtest: vecs0
[420.897163] Dynamic subtest vecs0: SUCCESS (20.101s)
[420.955482] Starting dynamic subtest: ccs0
[422.591664] Dynamic subtest ccs0: SUCCESS (1.683s)
[422.594770] Subtest engines-mixed-process: SUCCESS (65.959s)
[422.777306] [052/142] (593s left) kms_psr (psr2_primary_render)
[423.288751] Starting subtest: psr2_primary_render
[426.588403] Subtest psr2_primary_render: SUCCESS (3.299s)
[427.550496] [053/142] (589s left) i915_getparams_basic (basic-subslice-total)
[427.933365] Starting subtest: basic-subslice-total
[427.940272] Subtest basic-subslice-total: SUCCESS (0.000s)
[428.087371] [054/142] (588s left) gem_exec_schedule (preempt-engines)
[428.527081] Starting subtest: preempt-engines
[428.531493] Starting dynamic subtest: rcs0
[431.002253] Dynamic subtest rcs0: SUCCESS (2.473s)
[431.056984] Starting dynamic subtest: bcs0
[433.492362] Dynamic subtest bcs0: SUCCESS (2.486s)
[433.545837] Starting dynamic subtest: vcs0
[436.007160] Dynamic subtest vcs0: SUCCESS (2.510s)
[436.056875] Starting dynamic subtest: vcs1
[438.447926] Dynamic subtest vcs1: SUCCESS (2.438s)
[438.501055] Starting dynamic subtest: vecs0
[440.891126] Dynamic subtest vecs0: SUCCESS (2.438s)
[440.944393] Starting dynamic subtest: ccs0
[443.405436] Dynamic subtest ccs0: SUCCESS (2.511s)
[443.409418] Subtest preempt-engines: SUCCESS (14.880s)
[443.908657] [055/142] (573s left) gem_exec_balancer (full-late)
[444.333270] Starting subtest: full-late
[453.487346] Subtest full-late: SUCCESS (9.155s)
[454.525745] [056/142] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[455.039364] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[466.706818] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (11.674s)
[466.982885] [057/142] (550s left) syncobj_basic (bad-fd-to-handle)
[467.360775] Starting subtest: bad-fd-to-handle
[467.364369] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[467.513710] [058/142] (549s left) gem_ctx_param (get-priority-new-ctx)
[467.888435] Starting subtest: get-priority-new-ctx
[467.892155] Subtest get-priority-new-ctx: SUCCESS (0.002s)
[468.050157] [059/142] (549s left) gem_exec_reloc (basic-cpu-gtt)
[468.450466] Subtest basic-cpu-gtt: SKIP (0.000s)
[468.593960] [060/142] (548s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[469.818520] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[469.827509] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[471.017090] [061/142] (546s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs)
[472.120189] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs
[472.126322] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[473.407242] [062/142] (544s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[473.899228] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[473.906348] Starting dynamic subtest: pipe-A-default-mode
[474.310550] Dynamic subtest pipe-A-default-mode: SKIP (0.397s)
[474.317489] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.411s)
[475.256255] [063/142] (542s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[476.145195] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[477.026774] [064/142] (540s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[477.573121] Starting subtest: x-tiled-8bpp-rotate-90
[477.635055] Subtest x-tiled-8bpp-rotate-90: SKIP (0.059s)
[477.828419] [065/142] (540s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[478.344361] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[488.688716] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SUCCESS (10.359s)
[488.971966] [066/142] (529s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[490.547156] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[490.559353] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.014s)
[491.407835] [067/142] (526s left) kms_rotation_crc (bad-pixel-format)
[491.890240] Starting subtest: bad-pixel-format
[491.901846] Subtest bad-pixel-format: SKIP (0.007s)
[492.055375] [068/142] (526s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs)
[493.005672] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs
[493.011509] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[494.467135] [069/142] (523s left) kms_dsc (dsc-basic)
[494.949514] Starting subtest: dsc-basic
[494.956341] Subtest dsc-basic: SKIP (0.003s)
[495.106652] [070/142] (523s left) gem_eio (suspend)
[496.938931] Starting subtest: suspend
[511.886132] Subtest suspend: SUCCESS (14.945s)
[513.694914] [071/142] (504s left) gem_userptr_blits (map-fixed-invalidate-busy)
[514.161368] Starting subtest: map-fixed-invalidate-busy
[514.167945] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[514.397258] [072/142] (504s left) kms_rotation_crc (exhaust-fences)
[514.886126] Starting subtest: exhaust-fences
[514.891498] Subtest exhaust-fences: SKIP (0.000s)
[515.015424] [073/142] (503s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[515.407118] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[515.561210] [074/142] (503s left) gem_exec_schedule (smoketest-all)
[516.001144] Starting subtest: smoketest-all
[548.833186] Subtest smoketest-all: SUCCESS (32.764s)
[549.767192] [075/142] (469s left) v3d/v3d_perfmon (create-two-perfmon)
[550.269560] Subtest create-two-perfmon: SKIP (0.000s)
[550.415948] [076/142] (468s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_mc_ccs)
[551.337586] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs
[551.344160] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[552.860255] [077/142] (466s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[554.367421] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[554.544751] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SUCCESS (0.177s)
[555.422465] [078/142] (463s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[555.937213] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[555.943613] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[556.102038] [079/142] (463s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[556.605392] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[556.612405] Starting dynamic subtest: pipe-A-default-mode
[560.229504] Dynamic subtest pipe-A-default-mode: SUCCESS (3.614s)
[560.232955] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (3.629s)
[561.188608] [080/142] (458s left) gem_render_copy_redux (flink)
[561.623813] Starting subtest: flink
[568.551685] Subtest flink: SUCCESS (6.927s)
[568.750081] [081/142] (450s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[569.271140] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[569.277873] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[569.449512] [082/142] (450s left) gem_lmem_swapping (massive)
[569.845063] Subtest massive: SKIP (0.000s)
[569.966404] [083/142] (449s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[570.334826] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[570.338111] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[570.489541] [084/142] (449s left) gem_mmap_wc (read-write-distinct)
[570.868368] Subtest read-write-distinct: SKIP (0.000s)
[570.993377] [085/142] (448s left) gem_reg_read (timestamp-moving)
[571.358703] Starting subtest: timestamp-moving
[572.360476] Subtest timestamp-moving: SUCCESS (1.001s)
[572.564864] [086/142] (447s left) kms_vblank (pipe-d-query-forked-busy)
[573.066710] Starting subtest: pipe-D-query-forked-busy
[577.395836] Subtest pipe-D-query-forked-busy: SUCCESS (4.332s)
[578.353504] [087/142] (441s left) kms_atomic_transition (plane-all-transition)
[578.834868] Starting subtest: plane-all-transition
[578.843345] Starting dynamic subtest: pipe-A-eDP-1
[583.991965] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.149s)
[584.464208] Starting dynamic subtest: pipe-B-eDP-1
[590.244478] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.833s)
[590.647409] Subtest plane-all-transition: SUCCESS (11.810s)
[591.613635] [088/142] (428s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[592.129914] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[592.137527] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[592.317271] [089/142] (427s left) gem_exec_balancer (parallel-balancer)
[593.551230] Starting subtest: parallel-balancer
[600.872974] Subtest parallel-balancer: SUCCESS (7.323s)
[601.089839] [090/142] (419s left) gem_softpin (allocator-evict)
[601.484269] Starting subtest: allocator-evict
[601.488434] Starting dynamic subtest: rcs0
[636.560428] Dynamic subtest rcs0: SUCCESS (35.073s)
[636.613852] Starting dynamic subtest: bcs0
[667.694362] Dynamic subtest bcs0: SUCCESS (31.129s)
[667.760208] Starting dynamic subtest: vcs0
[701.793511] Dynamic subtest vcs0: SUCCESS (34.094s)
[701.847496] Starting dynamic subtest: vcs1
[736.026734] Dynamic subtest vcs1: SUCCESS (34.226s)
[736.079320] Starting dynamic subtest: vecs0
[769.561169] Dynamic subtest vecs0: SUCCESS (33.528s)
[769.607628] Starting dynamic subtest: ccs0
[799.669317] Dynamic subtest ccs0: SUCCESS (30.104s)
[799.674216] Subtest allocator-evict: SUCCESS (198.187s)
[799.813692] [091/142] (220s left) gem_exec_fair (basic-flow)
[800.391423] Subtest basic-flow: SKIP (0.000s)
[800.631784] [092/142] (219s left) vgem_basic (bad-pad)
[801.015061] Starting subtest: bad-pad
[801.018398] Subtest bad-pad: SUCCESS (0.000s)
[801.156853] [093/142] (219s left) gem_mmap_gtt (bad-object)
[801.534153] Subtest bad-object: SKIP (0.000s)
[801.678258] [094/142] (218s left) kms_atomic_interruptible (universal-setplane-primary)
[802.183211] Starting subtest: universal-setplane-primary
[802.193476] Starting dynamic subtest: eDP-1-pipe-A
[810.036837] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.844s)
[810.040759] Subtest universal-setplane-primary: SUCCESS (7.856s)
[810.996828] [095/142] (209s left) api_intel_allocator (simple-allocator)
[811.362637] Starting subtest: simple-allocator
[811.366305] Starting dynamic subtest: basic
[811.376835] Dynamic subtest basic: SUCCESS (0.013s)
[811.428371] Starting dynamic subtest: parallel-one
[812.008479] Dynamic subtest parallel-one: SUCCESS (0.626s)
[812.064730] Starting dynamic subtest: print
[812.069326] Dynamic subtest print: SUCCESS (0.000s)
[812.125865] Starting dynamic subtest: reuse
[812.129138] Dynamic subtest reuse: SUCCESS (0.001s)
[812.180171] Starting dynamic subtest: reserve
[812.183475] Dynamic subtest reserve: SUCCESS (0.000s)
[812.240778] Starting dynamic subtest: fork-reopen-allocator
[812.244812] Dynamic subtest fork-reopen-allocator: SUCCESS (0.081s)
[812.248310] Subtest simple-allocator: SUCCESS (0.747s)
[812.325919] [096/142] (208s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[812.824910] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[812.829792] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[813.010289] [097/142] (207s left) gen7_exec_parse (basic-allocation)
[813.414629] Subtest basic-allocation: SKIP (0.000s)
[813.541357] [098/142] (207s left) gem_exec_parallel (engines)
[813.968472] Starting subtest: engines
[813.972142] Starting dynamic subtest: basic
[818.518900] Dynamic subtest basic: SUCCESS (4.547s)
[818.583658] Starting dynamic subtest: contexts
[824.871999] Dynamic subtest contexts: SUCCESS (6.346s)
[824.932895] Starting dynamic subtest: fds
[831.074851] Dynamic subtest fds: SUCCESS (6.198s)
[831.133281] Starting dynamic subtest: userptr
[835.546948] Dynamic subtest userptr: SUCCESS (4.468s)
[835.551147] Subtest engines: SUCCESS (21.580s)
[835.921827] [099/142] (185s left) kms_big_fb (linear-64bpp-rotate-270)
[836.489471] Starting subtest: linear-64bpp-rotate-270
[836.545503] Subtest linear-64bpp-rotate-270: SKIP (0.053s)
[836.744978] [100/142] (184s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[837.130806] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[837.255512] [101/142] (184s left) gem_ctx_persistence (smoketest)
[837.665130] Starting subtest: smoketest
[869.865116] Subtest smoketest: SUCCESS (32.206s)
[870.061951] [102/142] (151s left) kms_plane (plane-panning-top-left)
[870.568191] Starting subtest: plane-panning-top-left
[870.572129] Starting dynamic subtest: pipe-A-planes
[872.900598] Dynamic subtest pipe-A-planes: SUCCESS (2.325s)
[872.954331] Starting dynamic subtest: pipe-B-planes
[875.914287] Dynamic subtest pipe-B-planes: SUCCESS (3.005s)
[875.917707] Subtest plane-panning-top-left: SUCCESS (5.351s)
[876.881898] [103/142] (144s left) kms_chamelium_hpd (dp-hpd)
[877.768722] Subtest dp-hpd: SKIP (0.000s)
[878.652239] [104/142] (142s left) gem_pxp (regular-baseline-src-copy-readible)
[881.559658] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[881.715810] [105/142] (140s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[882.266555] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[885.351280] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (3.086s)
[885.678299] [106/142] (136s left) perf_pmu (busy-hang)
[886.062932] Starting subtest: busy-hang
[886.067425] Starting dynamic subtest: rcs0
[888.624215] Dynamic subtest rcs0: SUCCESS (2.560s)
[888.689333] Starting dynamic subtest: bcs0
[891.113766] Dynamic subtest bcs0: SUCCESS (2.485s)
[891.184806] Starting dynamic subtest: vcs0
[895.050111] Dynamic subtest vcs0: SUCCESS (3.931s)
[895.122236] Starting dynamic subtest: vcs1
[896.968535] Dynamic subtest vcs1: SUCCESS (1.914s)
[897.034693] Starting dynamic subtest: vecs0
[899.021462] Dynamic subtest vecs0: SUCCESS (2.048s)
[899.078903] Starting dynamic subtest: ccs0
[900.663929] Dynamic subtest ccs0: SUCCESS (1.639s)
[900.668504] Subtest busy-hang: SUCCESS (14.604s)
[900.852691] [107/142] (121s left) perf_pmu (invalid-open)
[901.245703] Starting subtest: invalid-open
[901.249717] Subtest invalid-open: SUCCESS (0.002s)
[901.450344] [108/142] (120s left) kms_frontbuffer_tracking (fbc-suspend)
[901.962762] Starting subtest: fbc-suspend
[942.603766] Subtest fbc-suspend: SUCCESS (40.643s)
[942.893520] [109/142] ( 79s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[943.437613] Starting subtest: y-tiled-32bpp-rotate-180
[943.445133] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[943.625319] [110/142] ( 78s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[944.791179] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[944.798900] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.004s)
[945.416172] [111/142] ( 76s left) syncobj_wait (reset-during-wait-for-submit)
[945.793000] Starting subtest: reset-during-wait-for-submit
[945.899341] Subtest reset-during-wait-for-submit: SUCCESS (0.105s)
[946.070186] [112/142] ( 76s left) api_intel_bb (reset-flags)
[946.439309] Starting subtest: reset-flags
[946.478892] Subtest reset-flags: SUCCESS (0.039s)
[946.671552] [113/142] ( 75s left) gem_mmap_gtt (basic-small-bo-tiledx)
[947.042684] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[947.164808] [114/142] ( 75s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[947.736414] Starting subtest: cursorB-vs-flipA-atomic
[947.754434] Subtest cursorB-vs-flipA-atomic: SKIP (0.016s)
[948.095404] [115/142] ( 74s left) kms_prime (basic-crc-vgem)
[952.044565] Starting subtest: basic-crc-vgem
[952.048427] Starting dynamic subtest: second-to-first
[955.137591] Dynamic subtest second-to-first: SUCCESS (3.094s)
[955.141240] Subtest basic-crc-vgem: SUCCESS (3.098s)
[955.327094] [116/142] ( 67s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[955.829358] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[955.836348] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[956.016589] [117/142] ( 66s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[956.522329] Starting subtest: psr-rgb565-draw-mmap-wc
[971.693481] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (15.168s)
[971.984834] [118/142] ( 51s left) gem_render_copy (yf-tiled-to-vebox-linear)
[972.389229] Starting subtest: yf-tiled-to-vebox-linear
[972.395783] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[972.679441] [119/142] ( 50s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[973.179659] Starting subtest: fbcpsr-rgb565-draw-render
[987.462872] Subtest fbcpsr-rgb565-draw-render: SUCCESS (14.285s)
[987.788451] [120/142] ( 35s left) syncobj_timeline (wait-for-submit-delayed-submit)
[988.178887] Starting subtest: wait-for-submit-delayed-submit
[988.280446] Subtest wait-for-submit-delayed-submit: SUCCESS (0.105s)
[988.446774] [121/142] ( 34s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[988.930280] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[988.936114] Starting dynamic subtest: pipe-A-eDP-1
[988.983403] Dynamic subtest pipe-A-eDP-1: SKIP (0.041s)
[989.048467] Starting dynamic subtest: pipe-B-eDP-1
[989.138217] Dynamic subtest pipe-B-eDP-1: SKIP (0.146s)
[989.202938] Starting dynamic subtest: pipe-C-eDP-1
[989.301588] Dynamic subtest pipe-C-eDP-1: SKIP (0.150s)
[989.367267] Starting dynamic subtest: pipe-D-eDP-1
[989.462740] Dynamic subtest pipe-D-eDP-1: SKIP (0.150s)
[989.469524] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.532s)
[989.648806] [122/142] ( 33s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[990.021882] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[990.025662] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.002s)
[990.186661] [123/142] ( 33s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[990.579115] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[990.583521] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[990.686690] [124/142] ( 32s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[990.856988] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[990.861416] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[990.941674] [125/142] ( 32s left) kms_invalid_mode (bad-vtotal)
[991.044940] Starting subtest: bad-vtotal
[991.047349] Starting dynamic subtest: eDP-1-pipe-A
[991.349814] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.303s)
[991.358935] Starting dynamic subtest: eDP-1-pipe-B
[991.361673] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.011s)
[991.383357] Starting dynamic subtest: eDP-1-pipe-C
[991.385448] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.005s)
[991.405761] Starting dynamic subtest: eDP-1-pipe-D
[991.408332] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.005s)
[991.410355] Subtest bad-vtotal: SUCCESS (0.332s)
[992.224911] [126/142] ( 31s left) api_intel_allocator (fork-simple-once)
[992.293980] Starting subtest: fork-simple-once
[992.314269] Subtest fork-simple-once: SUCCESS (0.023s)
[992.511117] [127/142] ( 31s left) gem_ctx_param (root-set)
[992.883720] Starting subtest: root-set
[992.887238] Subtest root-set: SUCCESS (0.002s)
[993.047574] [128/142] ( 30s left) gem_userptr_blits (dmabuf-unsync)
[993.451861] Subtest dmabuf-unsync: SKIP (0.000s)
[993.744115] [129/142] ( 30s left) kms_atomic_transition (modeset-transition-nonblocking)
[994.223552] Starting subtest: modeset-transition-nonblocking
[994.227116] Starting dynamic subtest: 1x-outputs
[1026.179297] Dynamic subtest 1x-outputs: SUCCESS (31.956s)
[1026.706455] Subtest modeset-transition-nonblocking: SUCCESS (32.481s)
[1027.646782] Overall timeout time exceeded, stopping.
[1027.648145] Closing watchdogs
Done.