[25.329174] Initializing watchdogs
[25.329228]   /dev/watchdog0
[25.333746] [001/142] (960s left) gem_exec_schedule (promotion)
[25.398973] Starting subtest: promotion
[25.399833] Starting dynamic subtest: rcs0
[25.458513] Dynamic subtest rcs0: SUCCESS (0.059s)
[25.464880] Starting dynamic subtest: bcs0
[25.518507] Dynamic subtest bcs0: SUCCESS (0.060s)
[25.524868] Starting dynamic subtest: vcs0
[25.577528] Dynamic subtest vcs0: SUCCESS (0.058s)
[25.584765] Starting dynamic subtest: vcs1
[25.636247] Dynamic subtest vcs1: SUCCESS (0.059s)
[25.642716] Starting dynamic subtest: vecs0
[25.694814] Dynamic subtest vecs0: SUCCESS (0.058s)
[25.696248] Subtest promotion: SUCCESS (0.295s)
[25.965131] [002/142] (959s left) gem_exec_fence (expired-history)
[26.308298] Starting subtest: expired-history
[32.053181] Subtest expired-history: SUCCESS (5.737s)
[32.381901] [003/142] (953s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[32.479693] Starting subtest: short-flip-before-cursor-atomic-transitions
[33.091680] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.612s)
[33.182926] [004/142] (952s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[33.282338] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[33.283903] Starting dynamic subtest: pipe-A-HDMI-A-1
[33.345032] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.062s)
[33.349434] Starting dynamic subtest: pipe-B-HDMI-A-1
[33.461975] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.116s)
[33.466493] Starting dynamic subtest: pipe-C-HDMI-A-1
[33.579015] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.116s)
[33.583809] Starting dynamic subtest: pipe-D-HDMI-A-1
[33.686605] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.106s)
[33.687370] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.405s)
[33.824504] [005/142] (952s left) kms_flip (2x-wf_vblank-ts-check)
[33.905323] Starting subtest: 2x-wf_vblank-ts-check
[33.917966] Subtest 2x-wf_vblank-ts-check: SKIP (0.012s)
[33.958277] [006/142] (951s left) gem_mmap_wc (copy)
[34.006617] Starting subtest: copy
[34.121731] Subtest copy: SUCCESS (0.115s)
[34.158119] [007/142] (951s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[34.252827] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[34.253686] Starting dynamic subtest: pipe-A-valid-mode
[34.305707] Dynamic subtest pipe-A-valid-mode: SKIP (0.051s)
[34.307191] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.052s)
[34.375757] [008/142] (951s left) i915_pm_rc6_residency (media-rc6-accuracy)
[34.600036] Starting subtest: media-rc6-accuracy
[34.601907] Subtest media-rc6-accuracy: SKIP (0.000s)
[34.630167] [009/142] (951s left) gem_exec_fence (basic-wait-all)
[34.682790] Starting subtest: basic-wait-all
[34.712905] Subtest basic-wait-all: SUCCESS (0.030s)
[35.200943] [010/142] (950s left) perf (polling-small-buf)
[35.291730] Starting subtest: polling-small-buf
[35.379857] Subtest polling-small-buf: SUCCESS (0.088s)
[35.396666] [011/142] (950s left) gem_reg_read (timestamp-monotonic)
[35.445085] Starting subtest: timestamp-monotonic
[40.333419] Subtest timestamp-monotonic: SUCCESS (4.854s)
[40.340494] [012/142] (945s left) gen3_mixed_blits
[40.409362] [013/142] (945s left) core_getstats
[40.491914] [014/142] (945s left) kms_vblank (pipe-a-query-idle)
[40.593612] Starting subtest: pipe-A-query-idle
[41.738615] Subtest pipe-A-query-idle: SUCCESS (1.145s)
[41.829525] [015/142] (944s left) gem_ctx_persistence (engines-mixed)
[41.881049] Starting subtest: engines-mixed
[41.881853] Starting dynamic subtest: rcs0
[41.924989] Dynamic subtest rcs0: SUCCESS (0.044s)
[41.929146] Starting dynamic subtest: bcs0
[41.970917] Dynamic subtest bcs0: SUCCESS (0.046s)
[41.974876] Starting dynamic subtest: vcs0
[42.007227] Dynamic subtest vcs0: SUCCESS (0.036s)
[42.011959] Starting dynamic subtest: vcs1
[42.050618] Dynamic subtest vcs1: SUCCESS (0.043s)
[42.059433] Starting dynamic subtest: vecs0
[42.092459] Dynamic subtest vecs0: SUCCESS (0.042s)
[42.093470] Subtest engines-mixed: SUCCESS (0.211s)
[42.136339] [016/142] (943s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf_tiled_ccs)
[42.382896] Starting subtest: pipe-B-crc-sprite-planes-basic-yf_tiled_ccs
[42.385690] Subtest pipe-B-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.002s)
[42.587576] [017/142] (943s left) gem_eio (in-flight-contexts-10ms)
[42.644874] Starting subtest: in-flight-contexts-10ms
[56.200214] Subtest in-flight-contexts-10ms: SUCCESS (13.552s)
[56.291440] [018/142] (929s left) kms_big_joiner (invalid-modeset)
[56.390910] Subtest invalid-modeset: SKIP (0.000s)
[56.408857] [019/142] (929s left) gem_set_tiling_vs_gtt
[56.849205] [020/142] (929s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[56.949449] Starting subtest: flip-vs-cursor-crc-legacy
[57.251214] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.302s)
[57.350191] [021/142] (928s left) kms_cursor_legacy (forked-move)
[57.455181] Starting subtest: forked-move
[57.455928] Starting dynamic subtest: pipe-A
[62.879528] Dynamic subtest pipe-A: SUCCESS (5.414s)
[62.883839] Starting dynamic subtest: pipe-B
[68.307925] Dynamic subtest pipe-B: SUCCESS (5.429s)
[68.312964] Starting dynamic subtest: pipe-C
[73.731254] Dynamic subtest pipe-C: SUCCESS (5.432s)
[73.735606] Starting dynamic subtest: pipe-D
[79.165947] Dynamic subtest pipe-D: SUCCESS (5.426s)
[79.170965] Starting dynamic subtest: all-pipes
[84.596884] Dynamic subtest all-pipes: SUCCESS (5.430s)
[84.597943] Subtest forked-move: SUCCESS (27.133s)
[84.634857] [022/142] (901s left) v3d/v3d_create_bo (create-bo-4096)
[84.708744] Subtest create-bo-4096: SKIP (0.000s)
[84.739218] [023/142] (901s left) kms_atomic (plane-invalid-params-fence)
[84.890030] Starting subtest: plane-invalid-params-fence
[84.916371] Subtest plane-invalid-params-fence: SUCCESS (0.026s)
[85.086132] [024/142] (901s left) kms_addfb_basic (bad-pitch-256)
[85.138337] Starting subtest: bad-pitch-256
[85.139085] Subtest bad-pitch-256: SUCCESS (0.000s)
[85.242698] [025/142] (900s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs)
[85.566526] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs
[85.568053] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[85.691734] [026/142] (900s left) vc4/vc4_perfmon (destroy-invalid-perfmon)
[85.762901] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[85.791509] [027/142] (900s left) gem_exec_schedule (submit-late-slice)
[85.851455] Starting subtest: submit-late-slice
[85.852225] Starting dynamic subtest: rcs0
[85.873951] Dynamic subtest rcs0: SUCCESS (0.022s)
[85.878354] Starting dynamic subtest: bcs0
[85.894980] Dynamic subtest bcs0: SUCCESS (0.021s)
[85.899441] Starting dynamic subtest: vcs0
[85.915953] Dynamic subtest vcs0: SUCCESS (0.021s)
[85.920267] Starting dynamic subtest: vcs1
[85.937102] Dynamic subtest vcs1: SUCCESS (0.021s)
[85.941898] Starting dynamic subtest: vecs0
[85.957970] Dynamic subtest vecs0: SUCCESS (0.021s)
[85.958816] Subtest submit-late-slice: SUCCESS (0.106s)
[86.233260] [028/142] (899s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[86.345547] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[86.346949] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[86.400272] [029/142] (899s left) gem_ctx_isolation (preservation-s3)
[86.452226] Starting subtest: preservation-S3
[86.453047] Starting dynamic subtest: rcs0
[102.072694] Dynamic subtest rcs0: SUCCESS (1.316s)
[102.077132] Starting dynamic subtest: bcs0
[118.021921] Dynamic subtest bcs0: SUCCESS (1.226s)
[118.026377] Starting dynamic subtest: vcs0
[134.018949] Dynamic subtest vcs0: SUCCESS (1.246s)
[134.023340] Starting dynamic subtest: vcs1
[150.014882] Dynamic subtest vcs1: SUCCESS (1.237s)
[150.020471] Starting dynamic subtest: vecs0
[166.024082] Dynamic subtest vecs0: SUCCESS (1.249s)
[166.024971] Subtest preservation-S3: SUCCESS (6.275s)
[171.202791] [030/142] (893s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[171.311363] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[171.549738] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.239s)
[171.644783] [031/142] (892s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[171.931648] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[171.934870] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[172.101602] [032/142] (892s left) v3d/v3d_wait_bo (used-bo-0ns)
[172.171972] Subtest used-bo-0ns: SKIP (0.000s)
[172.201084] [033/142] (892s left) dmabuf_sync_file (import-multiple-read-only)
[172.255416] Starting subtest: import-multiple-read-only
[172.257529] Subtest import-multiple-read-only: SUCCESS (0.003s)
[172.284111] [034/142] (892s left) kms_cursor_legacy (torture-bo)
[172.379588] Starting subtest: torture-bo
[172.380465] Starting dynamic subtest: pipe-A
[177.849819] Dynamic subtest pipe-A: SUCCESS (5.469s)
[177.855454] Starting dynamic subtest: pipe-B
[183.330779] Dynamic subtest pipe-B: SUCCESS (5.481s)
[183.335217] Starting dynamic subtest: pipe-C
[188.805099] Dynamic subtest pipe-C: SUCCESS (5.474s)
[188.811112] Starting dynamic subtest: pipe-D
[194.277460] Dynamic subtest pipe-D: SUCCESS (5.472s)
[194.281798] Starting dynamic subtest: all-pipes
[199.757457] Dynamic subtest all-pipes: SUCCESS (5.480s)
[199.760709] Subtest torture-bo: SUCCESS (27.377s)
[199.807919] [035/142] (864s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[199.932056] Starting subtest: sprite-rotation-90-pos-100-0
[203.537219] Subtest sprite-rotation-90-pos-100-0: SUCCESS (3.605s)
[203.689770] [036/142] (860s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[203.790032] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[204.130452] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (0.340s)
[204.212384] [037/142] (860s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[204.551731] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs
[204.552509] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[204.652794] [038/142] (859s left) gem_exec_store (cachelines)
[204.706086] Starting subtest: cachelines
[204.706900] Starting dynamic subtest: rcs0
[204.756858] Dynamic subtest rcs0: SUCCESS (0.051s)
[204.762168] Starting dynamic subtest: bcs0
[204.793821] Dynamic subtest bcs0: SUCCESS (0.037s)
[204.798867] Starting dynamic subtest: vcs0
[204.816093] Dynamic subtest vcs0: SUCCESS (0.022s)
[204.820744] Starting dynamic subtest: vcs1
[204.848930] Dynamic subtest vcs1: SUCCESS (0.033s)
[204.853473] Starting dynamic subtest: vecs0
[204.875964] Dynamic subtest vecs0: SUCCESS (0.027s)
[204.876682] Subtest cachelines: SUCCESS (0.170s)
[205.019525] [039/142] (859s left) i915_pm_rpm (gem-mmap-type)
[206.537676] Starting subtest: gem-mmap-type
[206.538981] Starting dynamic subtest: gtt-smem0
[208.559514] Dynamic subtest gtt-smem0: SUCCESS (2.022s)
[208.572738] Starting dynamic subtest: wb-smem0
[209.144810] Dynamic subtest wb-smem0: SUCCESS (0.585s)
[209.150834] Starting dynamic subtest: wc-smem0
[209.853306] Dynamic subtest wc-smem0: SUCCESS (0.708s)
[209.860324] Starting dynamic subtest: uc-smem0
[210.554384] Dynamic subtest uc-smem0: SUCCESS (0.700s)
[210.555164] Subtest gem-mmap-type: SUCCESS (4.018s)
[210.632510] [040/142] (853s left) gem_exec_create (madvise)
[210.689694] Starting subtest: madvise
[210.690483] Starting dynamic subtest: smem
[230.843154] Dynamic subtest smem: SUCCESS (20.153s)
[230.844134] Subtest madvise: SUCCESS (20.153s)
[232.433278] [041/142] (832s left) gem_mmap_gtt (medium-copy-xy)
[232.480818] Starting subtest: medium-copy-XY
[237.917982] Subtest medium-copy-XY: SUCCESS (5.437s)
[237.956632] [042/142] (826s left) kms_color (ctm-red-to-blue)
[238.099787] Starting subtest: ctm-red-to-blue
[238.100625] Starting dynamic subtest: pipe-A
[238.388848] Dynamic subtest pipe-A: SUCCESS (0.289s)
[238.394579] Starting dynamic subtest: pipe-B
[238.660520] Dynamic subtest pipe-B: SUCCESS (0.271s)
[238.666284] Starting dynamic subtest: pipe-C
[238.921305] Dynamic subtest pipe-C: SUCCESS (0.260s)
[238.927136] Starting dynamic subtest: pipe-D
[239.190036] Dynamic subtest pipe-D: SUCCESS (0.269s)
[239.190769] Subtest ctm-red-to-blue: SUCCESS (1.091s)
[239.292932] [043/142] (825s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[239.395936] Starting subtest: fbcpsr-suspend
[239.397345] Subtest fbcpsr-suspend: SKIP (0.000s)
[239.451257] [044/142] (825s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[239.501438] Starting subtest: basic-write-cpu-read-gtt
[239.726817] Subtest basic-write-cpu-read-gtt: SUCCESS (0.225s)
[239.799841] [045/142] (824s left) kms_vblank (pipe-d-ts-continuation-modeset-rpm)
[239.903165] Starting subtest: pipe-D-ts-continuation-modeset-rpm
[241.504311] Subtest pipe-D-ts-continuation-modeset-rpm: SUCCESS (1.601s)
[241.601459] [046/142] (823s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[241.755096] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[241.756644] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[242.062373] [047/142] (822s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[242.162835] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[242.164366] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[242.228316] [048/142] (822s left) gem_exec_reloc (basic-concurrent0)
[242.279832] Starting subtest: basic-concurrent0
[247.675755] Subtest basic-concurrent0: SUCCESS (5.396s)
[247.762520] [049/142] (816s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[247.815841] Starting subtest: invalid-multi-wait-unsubmitted
[247.816722] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[247.854329] [050/142] (816s left) syncobj_basic (bad-create-flags)
[247.910130] Starting subtest: bad-create-flags
[247.910916] Subtest bad-create-flags: SUCCESS (0.000s)
[247.946819] [051/142] (816s left) gem_mmap_offset (open-flood)
[248.000679] Starting subtest: open-flood
[269.498660] Subtest open-flood: SUCCESS (21.499s)
[269.571455] [052/142] (795s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[269.705910] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[269.707321] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[269.757142] [053/142] (795s left) gem_ctx_shared (q-smoketest)
[269.812932] Starting subtest: Q-smoketest
[269.813794] Starting dynamic subtest: rcs0
[275.239607] Dynamic subtest rcs0: SUCCESS (5.413s)
[275.245747] Starting dynamic subtest: bcs0
[280.646945] Dynamic subtest bcs0: SUCCESS (5.414s)
[280.652484] Starting dynamic subtest: vcs0
[286.061775] Dynamic subtest vcs0: SUCCESS (5.414s)
[286.068358] Starting dynamic subtest: vcs1
[291.475074] Dynamic subtest vcs1: SUCCESS (5.413s)
[291.481688] Starting dynamic subtest: vecs0
[296.892187] Dynamic subtest vecs0: SUCCESS (5.417s)
[296.892948] Subtest Q-smoketest: SUCCESS (27.073s)
[297.046327] [054/142] (767s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[297.154070] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[298.281468] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.129s)
[298.367391] [055/142] (766s left) kms_cursor_crc (cursor-random-32x32)
[298.471279] Starting subtest: cursor-random-32x32
[298.515483] Subtest cursor-random-32x32: SKIP (0.042s)
[298.569756] [056/142] (766s left) sw_sync (sync_busy)
[298.619424] Starting subtest: sync_busy
[298.621147] Subtest sync_busy: SUCCESS (0.002s)
[298.653169] [057/142] (766s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[298.896422] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[298.898110] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[299.122590] [058/142] (765s left) kms_vblank (pipe-b-wait-forked-busy-hang)
[299.217994] Starting subtest: pipe-B-wait-forked-busy-hang
[313.399452] Subtest pipe-B-wait-forked-busy-hang: SUCCESS (14.181s)
[313.512765] [059/142] (751s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf_tiled_ccs)
[313.670356] Starting subtest: pipe-A-crc-primary-rotation-180-yf_tiled_ccs
[313.672678] Subtest pipe-A-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[313.962231] [060/142] (750s left) kms_chamelium_edid (dp-edid-read)
[314.113362] Subtest dp-edid-read: SKIP (0.000s)
[314.173345] [061/142] (750s left) gem_bad_reloc (negative-reloc-lut)
[314.223094] Starting subtest: negative-reloc-lut
[314.225392] Subtest negative-reloc-lut: SUCCESS (0.000s)
[314.296083] [062/142] (750s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[314.475732] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[314.478767] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[314.751022] [063/142] (750s left) kms_plane (pixel-format-source-clamping)
[314.847203] Starting subtest: pixel-format-source-clamping
[314.848002] Starting dynamic subtest: pipe-A-planes
[322.827947] Dynamic subtest pipe-A-planes: SUCCESS (7.980s)
[322.834169] Starting dynamic subtest: pipe-B-planes
[330.842422] Dynamic subtest pipe-B-planes: SUCCESS (8.012s)
[330.843230] Subtest pixel-format-source-clamping: SUCCESS (15.996s)
[330.951787] [064/142] (733s left) perf (i915-ref-count)
[331.040701] Starting subtest: i915-ref-count
[331.054210] Subtest i915-ref-count: SUCCESS (0.014s)
[331.074806] [065/142] (733s left) syncobj_timeline (reset-multiple-signaled)
[331.123003] Starting subtest: reset-multiple-signaled
[331.123793] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[331.160076] [066/142] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[331.261118] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[331.262617] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[331.301829] [067/142] (733s left) gem_exec_reloc (basic-cpu-wc)
[331.351251] Starting subtest: basic-cpu-wc
[331.356091] Subtest basic-cpu-wc: SUCCESS (0.005s)
[331.443733] [068/142] (733s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[331.544176] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[331.545666] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[331.593445] [069/142] (733s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-signaled)
[331.641411] Starting subtest: invalid-multi-wait-all-available-unsubmitted-signaled
[331.642197] Subtest invalid-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.000s)
[331.676448] [070/142] (733s left) i915_pm_rpm (universal-planes-dpms)
[333.262926] Starting subtest: universal-planes-dpms
[333.264272] Starting dynamic subtest: plane-31
[344.243729] Dynamic subtest plane-31: FAIL (10.968s)
[344.261758] Starting dynamic subtest: plane-40
[355.156108] Dynamic subtest plane-40: FAIL (10.870s)
[355.162081] Starting dynamic subtest: plane-49
[366.092662] Dynamic subtest plane-49: FAIL (10.926s)
[366.127384] Starting dynamic subtest: plane-58
[377.042134] Dynamic subtest plane-58: FAIL (10.903s)
[377.062919] Starting dynamic subtest: plane-67
[388.048702] Dynamic subtest plane-67: FAIL (10.978s)
[388.090779] Starting dynamic subtest: plane-76
[399.109776] Dynamic subtest plane-76: FAIL (11.002s)
[399.131927] Starting dynamic subtest: plane-85
[410.076901] Dynamic subtest plane-85: FAIL (10.935s)
[410.081699] Starting dynamic subtest: plane-94
[421.110255] Dynamic subtest plane-94: FAIL (11.025s)
[421.111127] Subtest universal-planes-dpms: FAIL (87.832s)
[421.227094] [071/142] (643s left) gem_pxp (create-valid-protected-context)
[423.801268] Subtest create-valid-protected-context: SKIP (0.000s)
[423.838052] [072/142] (641s left) kms_cursor_crc (cursor-onscreen-32x10)
[423.943092] Starting subtest: cursor-onscreen-32x10
[423.990748] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[424.035228] [073/142] (640s left) gem_readwrite (read-write)
[424.084546] Starting subtest: read-write
[424.096355] Subtest read-write: SUCCESS (0.000s)
[424.135104] [074/142] (640s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[424.236668] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[424.238143] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[424.293427] [075/142] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[424.415359] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[424.416930] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[424.451565] [076/142] (640s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[424.551882] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[424.553292] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[424.617610] [077/142] (640s left) gen9_exec_parse (batch-without-end)
[424.666601] Subtest batch-without-end: SKIP (0.000s)
[424.688104] [078/142] (640s left) kms_psr (cursor_blt)
[424.751849] Subtest cursor_blt: SKIP (0.000s)
[424.761707] [079/142] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[424.876281] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[424.877664] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[424.918561] [080/142] (640s left) kms_plane_scaling (plane-upscale-with-pixel-format-20x20)
[425.014249] Starting subtest: plane-upscale-with-pixel-format-20x20
[425.015027] Starting dynamic subtest: pipe-A-HDMI-A-1
[426.170688] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.156s)
[426.177749] Starting dynamic subtest: pipe-B-HDMI-A-1
[427.404822] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.231s)
[427.411109] Starting dynamic subtest: pipe-C-HDMI-A-1
[427.587588] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.181s)
[427.593753] Starting dynamic subtest: pipe-D-HDMI-A-1
[427.770601] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.181s)
[427.771404] Subtest plane-upscale-with-pixel-format-20x20: SUCCESS (2.757s)
[427.901523] [081/142] (637s left) gem_userptr_blits (set-cache-level)
[427.969662] Starting subtest: set-cache-level
[427.970413] Subtest set-cache-level: SUCCESS (0.000s)
[428.051132] [082/142] (637s left) api_intel_bb (simple-bb-ctx)
[428.100378] Starting subtest: simple-bb-ctx
[428.112582] Subtest simple-bb-ctx: SUCCESS (0.003s)
[428.167772] [083/142] (637s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb)
[428.215440] Subtest primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[428.235994] [084/142] (636s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[428.364735] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[428.380594] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[428.401557] [085/142] (636s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[428.501317] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[428.502960] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.012s)
[428.534596] [086/142] (636s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[428.643499] Starting subtest: 2x-flip-vs-rmfb-interruptible
[428.645154] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.013s)
[428.676556] [087/142] (636s left) kms_panel_fitting (legacy)
[428.771308] Starting subtest: legacy
[428.772793] Subtest legacy: SKIP (0.000s)
[428.810200] [088/142] (636s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[428.879348] Subtest bad-multisync-out-sync: SKIP (0.000s)
[428.909773] [089/142] (636s left) kms_legacy_colorkey (basic)
[429.007235] Starting subtest: basic
[429.008018] Starting dynamic subtest: pipe-A
[429.053249] Dynamic subtest pipe-A: SUCCESS (0.046s)
[429.058481] Starting dynamic subtest: pipe-B
[429.059300] Dynamic subtest pipe-B: SUCCESS (0.000s)
[429.064446] Starting dynamic subtest: pipe-C
[429.065221] Dynamic subtest pipe-C: SUCCESS (0.000s)
[429.070300] Starting dynamic subtest: pipe-D
[429.071072] Dynamic subtest pipe-D: SUCCESS (0.000s)
[429.071788] Subtest basic: SUCCESS (0.050s)
[429.093024] [090/142] (636s left) kms_vblank (pipe-c-ts-continuation-modeset-hang)
[429.188353] Starting subtest: pipe-C-ts-continuation-modeset-hang
[443.442399] Subtest pipe-C-ts-continuation-modeset-hang: SUCCESS (14.255s)
[443.547062] [091/142] (621s left) api_intel_allocator (open-vm)
[443.599350] Starting subtest: open-vm
[443.601117] Subtest open-vm: SUCCESS (0.002s)
[443.671167] [092/142] (621s left) api_intel_bb (destroy-bb)
[443.717907] Starting subtest: destroy-bb
[443.723170] Subtest destroy-bb: SUCCESS (0.006s)
[443.805206] [093/142] (621s left) gem_softpin (allocator-nopin)
[443.862859] Starting subtest: allocator-nopin
[443.925248] Subtest allocator-nopin: SUCCESS (0.062s)
[444.004934] [094/142] (621s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[444.229269] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[444.230827] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[444.457422] [095/142] (620s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[444.560841] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[445.683624] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (1.125s)
[445.767850] [096/142] (619s left) vc4/vc4_wait_seqno (bad-seqno-1ns)
[445.843035] Subtest bad-seqno-1ns: SKIP (0.000s)
[445.875604] [097/142] (619s left) syncobj_timeline (etime-multi-wait-all-submitted)
[445.926407] Starting subtest: etime-multi-wait-all-submitted
[446.032611] Subtest etime-multi-wait-all-submitted: SUCCESS (0.106s)
[446.081778] [098/142] (619s left) kms_chamelium_edid (hdmi-mode-timings)
[446.234983] Subtest hdmi-mode-timings: SKIP (0.000s)
[446.293664] [099/142] (619s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[446.586197] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[446.587060] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s)
[446.747196] [100/142] (618s left) gem_exec_balancer (bonded-true-hang)
[446.983875] Starting subtest: bonded-true-hang
[447.753633] Subtest bonded-true-hang: SUCCESS (0.770s)
[447.797007] [101/142] (617s left) gem_mmap_gtt (fault-concurrent-y)
[447.845863] Starting subtest: fault-concurrent-Y
[450.301300] Subtest fault-concurrent-Y: SUCCESS (2.456s)
[450.377571] [102/142] (615s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[450.446752] Starting subtest: invalid-single-wait-all-unsubmitted
[450.447530] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[450.489354] [103/142] (614s left) i915_pciid
[450.580349] [104/142] (614s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[450.691492] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[450.692998] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[450.748259] [105/142] (614s left) gem_wait (write-busy)
[450.804283] Starting subtest: write-busy
[450.805054] Starting dynamic subtest: all-engines
[451.328042] Dynamic subtest all-engines: SUCCESS (0.523s)
[451.333539] Starting dynamic subtest: rcs0
[451.842211] Dynamic subtest rcs0: SUCCESS (0.513s)
[451.847574] Starting dynamic subtest: bcs0
[452.357137] Dynamic subtest bcs0: SUCCESS (0.514s)
[452.362570] Starting dynamic subtest: vcs0
[452.869819] Dynamic subtest vcs0: SUCCESS (0.512s)
[452.875353] Starting dynamic subtest: vcs1
[453.381821] Dynamic subtest vcs1: SUCCESS (0.511s)
[453.387427] Starting dynamic subtest: vecs0
[453.894136] Dynamic subtest vecs0: SUCCESS (0.512s)
[453.895013] Subtest write-busy: SUCCESS (3.090s)
[454.062315] [106/142] (611s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[454.164907] Starting subtest: multiplane-rotation-cropping-top
[463.568979] Subtest multiplane-rotation-cropping-top: SUCCESS (9.405s)
[463.635156] [107/142] (601s left) gem_partial_pwrite_pread (write-display)
[463.692969] Starting subtest: write-display
[473.711554] Subtest write-display: SUCCESS (10.019s)
[473.792244] [108/142] (591s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[473.895354] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[473.896870] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[473.943018] [109/142] (591s left) gem_exec_balancer (individual)
[473.995599] Starting subtest: individual
[475.049087] Subtest individual: SUCCESS (1.053s)
[475.275817] [110/142] (590s left) v3d/v3d_get_param (get-bad-flags)
[475.345845] Subtest get-bad-flags: SKIP (0.000s)
[475.377716] [111/142] (590s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[475.485716] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[476.012407] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.526s)
[476.093097] [112/142] (589s left) kms_big_fb (linear-32bpp-rotate-90)
[476.196359] Starting subtest: linear-32bpp-rotate-90
[476.248999] Subtest linear-32bpp-rotate-90: SKIP (0.052s)
[476.320586] [113/142] (589s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[476.423394] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[476.424930] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[476.470166] [114/142] (589s left) kms_invalid_mode (bad-hsync-start)
[476.569363] Starting subtest: bad-hsync-start
[476.570155] Starting dynamic subtest: HDMI-A-1-pipe-A
[476.631797] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.063s)
[476.638464] Starting dynamic subtest: HDMI-A-1-pipe-B
[476.650219] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.016s)
[476.655980] Starting dynamic subtest: HDMI-A-1-pipe-C
[476.656771] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.001s)
[476.662504] Starting dynamic subtest: HDMI-A-1-pipe-D
[476.663607] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (0.001s)
[476.664424] Subtest bad-hsync-start: SUCCESS (0.086s)
[476.746236] [115/142] (588s left) gem_lmem_swapping (parallel-random-verify-ccs)
[476.797982] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[476.822360] [116/142] (588s left) perf (global-sseu-config)
[476.904106] Starting subtest: global-sseu-config
[476.904854] Starting dynamic subtest: 0-rcs0
[476.922457] Dynamic subtest 0-rcs0: SUCCESS (0.018s)
[476.923346] Subtest global-sseu-config: SUCCESS (0.019s)
[476.944227] [117/142] (588s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[477.046157] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[478.123621] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (1.080s)
[478.231336] [118/142] (587s left) kms_addfb_basic (small-bo)
[478.337008] Starting subtest: small-bo
[478.337768] Subtest small-bo: SUCCESS (0.000s)
[478.387594] [119/142] (587s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_mc_ccs)
[478.679467] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs
[478.681016] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[478.832451] [120/142] (586s left) kms_plane_lowres (tiling-none)
[478.929066] Starting subtest: tiling-none
[478.929877] Starting dynamic subtest: pipe-A-HDMI-A-1
[483.645817] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.716s)
[483.717702] Starting dynamic subtest: pipe-B-HDMI-A-1
[488.283839] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.571s)
[488.334028] Starting dynamic subtest: pipe-C-HDMI-A-1
[492.921673] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (4.593s)
[492.993234] Starting dynamic subtest: pipe-D-HDMI-A-1
[497.576901] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.588s)
[497.617214] Subtest tiling-none: SUCCESS (18.688s)
[497.738587] [121/142] (567s left) gem_create (create-ext-cpu-access-big)
[497.901218] Starting subtest: create-ext-cpu-access-big
[497.902677] Subtest create-ext-cpu-access-big: SKIP (0.000s)
[497.938361] [122/142] (567s left) gem_exec_fence (syncobj-unused-fence)
[498.237810] Starting subtest: syncobj-unused-fence
[498.239642] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[498.489127] [123/142] (567s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[498.802314] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[498.803789] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[498.933850] [124/142] (566s left) kms_async_flips (crc)
[499.032502] Starting subtest: crc
[499.184822] Starting dynamic subtest: pipe-A-HDMI-A-1
[501.657605] Dynamic subtest pipe-A-HDMI-A-1: FAIL (2.428s)
[501.790084] Starting dynamic subtest: pipe-B-HDMI-A-1
[504.096534] Dynamic subtest pipe-B-HDMI-A-1: FAIL (2.268s)
[504.167141] Starting dynamic subtest: pipe-C-HDMI-A-1
[506.486072] Dynamic subtest pipe-C-HDMI-A-1: FAIL (2.283s)
[506.605851] Starting dynamic subtest: pipe-D-HDMI-A-1
[508.968666] Dynamic subtest pipe-D-HDMI-A-1: FAIL (2.159s)
[508.969361] Subtest crc: FAIL (9.729s)
[508.983954] [125/142] (556s left) gem_mmap (short-mmap)
[509.035455] Starting subtest: short-mmap
[509.036191] Subtest short-mmap: SUCCESS (0.000s)
[509.104082] [126/142] (556s left) kms_flip (2x-plain-flip)
[509.183385] Starting subtest: 2x-plain-flip
[509.195357] Subtest 2x-plain-flip: SKIP (0.012s)
[509.236445] [127/142] (556s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[509.283719] Starting subtest: single-wait-all-for-submit-available-signaled
[509.284449] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[509.328483] [128/142] (556s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs)
[509.587968] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs
[509.589500] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[509.818154] [129/142] (556s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[509.918524] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[509.919942] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[509.984528] [130/142] (555s left) perf (mi-rpc)
[510.068495] Starting subtest: mi-rpc
[510.070032] Subtest mi-rpc: SKIP (0.000s)
[510.090568] [131/142] (555s left) gem_mmap_wc (read-write)
[510.137636] Starting subtest: read-write
[510.138452] Subtest read-write: SUCCESS (0.001s)
[510.209366] [132/142] (555s left) gem_exec_flush (basic-wb-prw-default)
[510.266268] Starting subtest: basic-wb-prw-default
[515.684930] Subtest basic-wb-prw-default: SUCCESS (5.419s)
[515.849403] [133/142] (550s left) gem_mmap_wc (write-read)
[515.917538] Starting subtest: write-read
[515.918313] Subtest write-read: SUCCESS (0.001s)
[515.974180] [134/142] (549s left) gem_mmap_gtt (big-bo-tiledy)
[516.031544] Starting subtest: big-bo-tiledY
[516.498561] Subtest big-bo-tiledY: SUCCESS (0.468s)
[516.571969] [135/142] (549s left) gem_ppgtt (blt-vs-render-ctxn)
[516.655018] Starting subtest: blt-vs-render-ctxN
[549.034281] Subtest blt-vs-render-ctxN: SUCCESS (32.379s)
[549.123067] [136/142] (516s left) kms_big_fb (x-tiled-addfb)
[549.274840] Starting subtest: x-tiled-addfb
[549.275663] Subtest x-tiled-addfb: SUCCESS (0.000s)
[549.340737] [137/142] (516s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf_tiled_ccs)
[549.648157] Starting subtest: pipe-C-crc-sprite-planes-basic-yf_tiled_ccs
[549.650946] Subtest pipe-C-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.002s)
[549.799434] [138/142] (516s left) kms_content_protection (atomic-dpms)
[549.902321] Starting subtest: atomic-dpms
[550.183461] Subtest atomic-dpms: SKIP (0.278s)
[550.327252] [139/142] (515s left) prime_mmap_coherency (write)
[550.382849] Starting subtest: write
[555.773520] Subtest write: SUCCESS (5.390s)
[555.896107] [140/142] (510s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[555.946955] Starting subtest: yf-tiled-ccs-to-y-tiled
[555.947820] Starting dynamic subtest: smem
[556.048239] Dynamic subtest smem: SUCCESS (0.101s)
[556.049080] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.101s)
[556.210078] [141/142] (509s left) vgem_basic (dmabuf-fence)
[556.270119] Starting subtest: dmabuf-fence
[556.270952] Subtest dmabuf-fence: SUCCESS (0.000s)
[556.310460] [142/142] (509s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[556.415521] Starting subtest: 4-tiled-64bpp-rotate-180
[556.417169] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[556.474161] Closing watchdogs
Done.