[49.096085] Initializing watchdogs
[49.096328]   /dev/watchdog0
[49.129171] [001/142] (960s left) gem_ctx_isolation (nonpriv-switch)
[49.500620] Starting subtest: nonpriv-switch
[49.525221] Starting dynamic subtest: rcs0
[51.926222] Dynamic subtest rcs0: SUCCESS (2.440s)
[51.956362] Starting dynamic subtest: bcs0
[55.225280] Dynamic subtest bcs0: SUCCESS (3.125s)
[55.258461] Starting dynamic subtest: vcs0
[57.569212] Dynamic subtest vcs0: SUCCESS (2.345s)
[57.599768] Starting dynamic subtest: vecs0
[59.912999] Dynamic subtest vecs0: SUCCESS (2.340s)
[59.933432] Subtest nonpriv-switch: SUCCESS (10.251s)
[60.014256] [002/142] (949s left) kms_plane_cursor (viewport)
[60.401060] Starting subtest: viewport
[60.443369] Starting dynamic subtest: pipe-A-DP-1-size-64
[62.887279] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.504s)
[62.962042] Starting dynamic subtest: pipe-A-DP-1-size-128
[65.372626] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.433s)
[65.448212] Starting dynamic subtest: pipe-A-DP-1-size-256
[67.854191] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.433s)
[68.051915] Starting dynamic subtest: pipe-B-DP-1-size-64
[70.676271] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.666s)
[70.751965] Starting dynamic subtest: pipe-B-DP-1-size-128
[73.155824] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.433s)
[73.232616] Starting dynamic subtest: pipe-B-DP-1-size-256
[75.691061] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.483s)
[75.890897] Starting dynamic subtest: pipe-C-DP-1-size-64
[78.526227] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.664s)
[78.591952] Starting dynamic subtest: pipe-C-DP-1-size-128
[80.974137] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.416s)
[81.045865] Starting dynamic subtest: pipe-C-DP-1-size-256
[83.455735] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.433s)
[83.611984] Subtest viewport: SUCCESS (23.225s)
[83.970123] [003/142] (925s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[84.450230] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[84.487357] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[84.594051] [004/142] (925s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[85.027734] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[85.069345] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[85.168419] [005/142] (924s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[85.609561] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[85.646857] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[85.749509] [006/142] (924s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[86.175329] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[86.256613] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.033s)
[86.358514] [007/142] (923s left) gem_ctx_persistence (engines-mixed-process)
[86.655287] Starting subtest: engines-mixed-process
[86.674450] Starting dynamic subtest: rcs0
[87.006676] Dynamic subtest rcs0: SUCCESS (0.360s)
[87.041295] Starting dynamic subtest: bcs0
[87.364668] Dynamic subtest bcs0: SUCCESS (0.365s)
[87.399870] Starting dynamic subtest: vcs0
[87.721924] Dynamic subtest vcs0: SUCCESS (0.354s)
[87.757651] Starting dynamic subtest: vecs0
[88.071285] Dynamic subtest vecs0: SUCCESS (0.348s)
[88.092635] Subtest engines-mixed-process: SUCCESS (1.430s)
[88.198146] [008/142] (922s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[88.601107] Starting subtest: psr-rgb565-draw-render
[88.643999] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[88.749071] [009/142] (921s left) gem_exec_balancer (indices)
[89.066436] Starting subtest: indices
[93.049328] Subtest indices: SUCCESS (3.818s)
[96.989675] [010/142] (913s left) kms_flip (2x-wf_vblank-ts-check)
[97.369872] Starting subtest: 2x-wf_vblank-ts-check
[97.412488] Subtest 2x-wf_vblank-ts-check: SKIP (0.003s)
[97.514678] [011/142] (913s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_mc_ccs)
[98.236224] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs
[98.278845] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[98.594244] [012/142] (912s left) api_intel_bb (object-noreloc-purge-cache-simple)
[98.891668] Starting subtest: object-noreloc-purge-cache-simple
[98.910204] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.008s)
[99.019211] [013/142] (911s left) kms_cursor_edge_walk (64x64-left-edge)
[99.376040] Starting subtest: 64x64-left-edge
[99.394660] Starting dynamic subtest: pipe-A-DP-1
[103.205383] Dynamic subtest pipe-A-DP-1: SUCCESS (3.821s)
[103.240945] Starting dynamic subtest: pipe-C-DP-1
[106.689201] Dynamic subtest pipe-C-DP-1: SUCCESS (3.471s)
[106.708736] Subtest 64x64-left-edge: SUCCESS (7.299s)
[107.038119] [014/142] (903s left) i915_pm_backlight (fade-with-suspend)
[107.419825] Subtest fade-with-suspend: SKIP (0.000s)
[107.531514] [015/142] (903s left) kms_lease (lessee_list)
[107.906612] Starting subtest: lessee_list
[107.941903] Starting dynamic subtest: pipe-A-DP-1
[107.966381] Dynamic subtest pipe-A-DP-1: SUCCESS (0.003s)
[108.003218] Starting dynamic subtest: pipe-B-DP-1
[108.027541] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s)
[108.064915] Starting dynamic subtest: pipe-C-DP-1
[108.089454] Dynamic subtest pipe-C-DP-1: SUCCESS (0.002s)
[108.116183] Subtest lessee_list: SUCCESS (0.014s)
[108.242526] [016/142] (902s left) perf (oa-formats)
[108.693446] Starting subtest: oa-formats
[108.715130] Starting dynamic subtest: 0-rcs0
[108.895059] Dynamic subtest 0-rcs0: SUCCESS (0.197s)
[108.913623] Subtest oa-formats: SUCCESS (0.197s)
[109.021595] [017/142] (902s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[109.383228] Starting subtest: cursorB-vs-flipB-toggle
[109.420784] Subtest cursorB-vs-flipB-toggle: SKIP (0.002s)
[109.530699] [018/142] (901s left) gem_exec_nop (basic-parallel)
[109.988854] Starting subtest: basic-parallel
[112.964157] Subtest basic-parallel: SUCCESS (3.143s)
[113.213833] [019/142] (898s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[113.749607] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[113.789377] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.005s)
[114.307230] [020/142] (897s left) gem_tiled_wc
[117.417602] [021/142] (894s left) gem_exec_whisper (basic-normal)
[117.753767] Starting subtest: basic-normal
[124.234927] Subtest basic-normal: SUCCESS (6.333s)
[124.324380] [022/142] (887s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[124.809458] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[125.115720] [023/142] (886s left) prime_self_import (basic-with_two_bos)
[125.391215] Starting subtest: basic-with_two_bos
[125.428102] Subtest basic-with_two_bos: SUCCESS (0.008s)
[125.534068] [024/142] (886s left) gem_mmap_gtt (basic-small-copy-xy)
[125.824675] Starting subtest: basic-small-copy-XY
[129.916367] Subtest basic-small-copy-XY: SUCCESS (4.123s)
[130.033087] [025/142] (881s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-5)
[130.572768] Starting subtest: plane-downscale-with-pixel-format-factor-0-5
[130.591900] Starting dynamic subtest: pipe-A-DP-1
[133.273188] Dynamic subtest pipe-A-DP-1: SUCCESS (2.682s)
[133.311342] Starting dynamic subtest: pipe-B-DP-1
[135.899080] Dynamic subtest pipe-B-DP-1: SUCCESS (2.620s)
[135.942689] Starting dynamic subtest: pipe-C-DP-1
[136.236558] Dynamic subtest pipe-C-DP-1: SUCCESS (0.355s)
[136.257084] Subtest plane-downscale-with-pixel-format-factor-0-5: SUCCESS (5.667s)
[136.681830] [026/142] (875s left) i915_suspend (fence-restore-tiled2untiled)
[136.980397] Starting subtest: fence-restore-tiled2untiled
[157.581947] Subtest fence-restore-tiled2untiled: SUCCESS (4.391s)
[160.525739] [027/142] (870s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[160.890281] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[160.927430] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[161.614998] [028/142] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[162.055350] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[162.097050] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[162.203668] [029/142] (869s left) kms_selftest (drm_format)
[162.480611] Starting subtest: drm_format
[162.546689] Subtest drm_format: SKIP (0.051s)
[162.658610] [030/142] (868s left) gem_mmap_offset (perf)
[162.951426] Starting subtest: perf
[162.972628] Starting dynamic subtest: smem0
[163.306738] Dynamic subtest smem0: SUCCESS (0.295s)
[163.327128] Subtest perf: SUCCESS (0.296s)
[163.430827] [031/142] (868s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[163.859436] Starting subtest: x-tiled-16bpp-rotate-180
[167.662285] Subtest x-tiled-16bpp-rotate-180: SUCCESS (3.838s)
[168.031461] [032/142] (863s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[168.421757] Starting subtest: cursor-rapid-movement-128x128
[168.441551] Starting dynamic subtest: pipe-A-DP-1
[168.961609] Dynamic subtest pipe-A-DP-1: SUCCESS (0.509s)
[169.033690] Starting dynamic subtest: pipe-C-DP-1
[169.867819] Dynamic subtest pipe-C-DP-1: SUCCESS (0.850s)
[169.889594] Subtest cursor-rapid-movement-128x128: SUCCESS (1.435s)
[170.273107] [033/142] (861s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[170.706951] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[170.749663] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[170.859174] [034/142] (861s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[171.155668] Starting subtest: multi-wait-all-for-submit-available-signaled
[171.174639] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s)
[171.283328] [035/142] (860s left) gem_softpin (overlap)
[171.579894] Starting subtest: overlap
[174.822891] Subtest overlap: SUCCESS (3.061s)
[174.912397] [036/142] (857s left) dumb_buffer (map-invalid-size)
[175.210977] Starting subtest: map-invalid-size
[175.229908] Subtest map-invalid-size: SUCCESS (0.000s)
[175.317370] [037/142] (856s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[175.705917] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[175.726527] Starting dynamic subtest: pipe-A-valid-mode
[175.833466] Dynamic subtest pipe-A-valid-mode: SKIP (0.116s)
[175.876706] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.119s)
[176.198281] [038/142] (856s left) syncobj_basic (bad-handle-to-fd)
[176.490639] Starting subtest: bad-handle-to-fd
[176.509480] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[176.619412] [039/142] (855s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[177.039060] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[177.076833] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[177.191965] [040/142] (855s left) gem_exec_suspend (basic-s3-devices)
[177.486442] Starting subtest: basic-S3-devices
[177.508324] Starting dynamic subtest: smem
[187.201327] Dynamic subtest smem: SUCCESS (9.711s)
[187.222847] Subtest basic-S3-devices: SUCCESS (9.712s)
[192.621358] [041/142] (845s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[193.043005] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[193.082814] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[193.199043] [042/142] (844s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[193.614093] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[193.656081] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[193.766982] [043/142] (844s left) gen9_exec_parse (batch-invalid-length)
[194.068637] Starting subtest: batch-invalid-length
[194.087409] Subtest batch-invalid-length: SUCCESS (0.009s)
[194.333120] [044/142] (843s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[194.692293] Starting subtest: modeset-transition-nonblocking-fencing
[194.711074] Starting dynamic subtest: 1x-outputs
[199.451642] Dynamic subtest 1x-outputs: SUCCESS (4.767s)
[199.566511] Subtest modeset-transition-nonblocking-fencing: SUCCESS (4.873s)
[199.954564] [045/142] (838s left) kms_psr2_sf (cursor-plane-move-continuous-sf)
[200.308805] Subtest cursor-plane-move-continuous-sf: SKIP (0.000s)
[200.415359] [046/142] (837s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[200.834952] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[201.943604] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.149s)
[202.337285] [047/142] (836s left) kms_chamelium_hpd (hdmi-hpd-fast)
[202.808396] Subtest hdmi-hpd-fast: SKIP (0.000s)
[203.170646] [048/142] (835s left) gem_softpin (zero)
[203.486688] Starting subtest: zero
[203.536834] Subtest zero: SUCCESS (0.007s)
[203.668656] [049/142] (834s left) kms_psr (psr2_primary_mmap_cpu)
[203.996809] Subtest psr2_primary_mmap_cpu: SKIP (0.000s)
[204.109398] [050/142] (834s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[204.405152] Starting subtest: x-tiled-to-vebox-yf-tiled
[204.444333] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[204.638286] [051/142] (834s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[204.926558] Starting subtest: y-tiled-ccs-to-x-tiled
[204.946906] Starting dynamic subtest: smem
[205.209264] Dynamic subtest smem: SUCCESS (0.296s)
[205.227742] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.297s)
[205.466793] [052/142] (833s left) gem_exec_params (invalid-bsd-ring)
[205.762896] Starting subtest: invalid-bsd-ring
[205.783686] Subtest invalid-bsd-ring: SUCCESS (0.002s)
[205.894122] [053/142] (833s left) perf_pmu (frequency)
[206.192737] Starting subtest: frequency
[206.211552] Starting dynamic subtest: gt0
[208.311673] Dynamic subtest gt0: SUCCESS (2.105s)
[208.352858] Starting dynamic subtest: idle-gt0
[208.804929] Dynamic subtest idle-gt0: SUCCESS (0.506s)
[208.823992] Subtest frequency: SUCCESS (2.615s)
[208.954900] [054/142] (830s left) prime_mmap (test_forked)
[209.250545] Starting subtest: test_forked
[209.272767] Starting dynamic subtest: test_forked-smem
[209.294132] Dynamic subtest test_forked-smem: SUCCESS (0.041s)
[209.315152] Subtest test_forked: SUCCESS (0.042s)
[209.423812] [055/142] (829s left) template (b)
[209.715277] Starting subtest: B
[209.733950] Subtest B: SUCCESS (0.000s)
[209.847630] [056/142] (829s left) kms_vblank (pipe-a-query-forked-hang)
[210.210442] Starting subtest: pipe-A-query-forked-hang
[217.395342] Subtest pipe-A-query-forked-hang: SUCCESS (7.063s)
[217.661104] [057/142] (821s left) v3d/v3d_submit_cl (single-out-sync)
[218.006978] Subtest single-out-sync: SKIP (0.000s)
[218.113507] [058/142] (821s left) perf_pmu (gt-awake)
[218.388440] Starting subtest: gt-awake
[220.930370] Subtest gt-awake: SUCCESS (2.552s)
[221.051138] [059/142] (818s left) syncobj_timeline (invalid-transfer-non-existent-point)
[221.341833] Starting subtest: invalid-transfer-non-existent-point
[221.360553] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[221.455155] [060/142] (818s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[221.894346] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[221.934418] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[222.047476] [061/142] (817s left) i915_pm_rpm (fences-dpms)
[223.919967] Starting subtest: fences-dpms
[226.766785] Subtest fences-dpms: SUCCESS (2.847s)
[227.032522] [062/142] (812s left) kms_universal_plane (universal-plane-pipe-d-sanity)
[227.417824] Subtest universal-plane-pipe-D-sanity: SKIP (0.000s)
[227.612788] [063/142] (812s left) perf (gen12-group-concurrent-oa-buffer-read)
[228.079592] Starting subtest: gen12-group-concurrent-oa-buffer-read
[238.362321] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.124s)
[238.460028] [064/142] (801s left) kms_big_fb (yf-tiled-addfb)
[238.852972] Starting subtest: yf-tiled-addfb
[238.871649] Subtest yf-tiled-addfb: SUCCESS (0.000s)
[238.993411] [065/142] (801s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[239.758157] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[240.100534] [066/142] (800s left) kms_vblank (pipe-c-query-forked-busy)
[240.463336] Starting subtest: pipe-C-query-forked-busy
[243.460276] Subtest pipe-C-query-forked-busy: SUCCESS (2.985s)
[243.832118] [067/142] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[244.270816] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[244.313142] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[244.424188] [068/142] (796s left) gem_gtt_cpu_tlb
[244.885386] [069/142] (795s left) gem_mmap_wc (close)
[245.200326] Starting subtest: close
[245.249978] Subtest close: SUCCESS (0.087s)
[245.375468] [070/142] (795s left) gem_softpin (evict-prime-sanity-check)
[245.673004] Starting subtest: evict-prime-sanity-check
[245.691842] Starting dynamic subtest: rcs0
[246.761373] Dynamic subtest rcs0: SUCCESS (1.112s)
[246.805884] Starting dynamic subtest: bcs0
[247.866775] Dynamic subtest bcs0: SUCCESS (1.105s)
[247.907990] Starting dynamic subtest: vcs0
[248.978631] Dynamic subtest vcs0: SUCCESS (1.105s)
[249.021131] Starting dynamic subtest: vecs0
[250.089332] Dynamic subtest vecs0: SUCCESS (1.112s)
[250.133659] Starting dynamic subtest: all
[251.207364] Dynamic subtest all: SUCCESS (1.115s)
[251.226443] Subtest evict-prime-sanity-check: SUCCESS (5.564s)
[251.325933] [071/142] (789s left) kms_addfb_basic (clobberred-modifier)
[251.624465] Starting subtest: clobberred-modifier
[251.643246] Subtest clobberred-modifier: SUCCESS (0.000s)
[251.841161] [072/142] (789s left) gem_exec_params (larger-than-life-batch)
[252.133292] Starting subtest: larger-than-life-batch
[252.639534] Subtest larger-than-life-batch: SKIP (0.350s)
[252.760160] [073/142] (788s left) gem_linear_blits (normal)
[253.339281] Starting subtest: normal
[268.921759] Subtest normal: SUCCESS (15.582s)
[269.341867] [074/142] (771s left) kms_frontbuffer_tracking (fbc-tiling-y)
[269.969262] Starting subtest: fbc-tiling-y
[272.154938] Subtest fbc-tiling-y: SUCCESS (2.262s)
[272.312367] [075/142] (769s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[272.638610] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[272.740268] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[272.856718] [076/142] (768s left) kms_psr (primary_page_flip)
[273.175784] Subtest primary_page_flip: SKIP (0.000s)
[273.269399] [077/142] (768s left) gem_ctx_param (invalid-param-get)
[273.565782] Starting subtest: invalid-param-get
[273.585894] Subtest invalid-param-get: SUCCESS (0.000s)
[273.682776] [078/142] (767s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[274.028391] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[274.118904] [079/142] (767s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[274.850295] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[275.189931] [080/142] (766s left) sw_sync (sync_random_merge)
[275.468866] Starting subtest: sync_random_merge
[275.606085] Subtest sync_random_merge: SUCCESS (0.153s)
[275.724363] [081/142] (766s left) vc4/vc4_wait_bo (bad-pad)
[276.059289] Subtest bad-pad: SKIP (0.000s)
[276.172925] [082/142] (765s left) gem_exec_schedule (wide)
[276.654145] Starting subtest: wide
[276.673324] Starting dynamic subtest: rcs0
[297.210700] Dynamic subtest rcs0: SUCCESS (20.576s)
[297.262224] Starting dynamic subtest: bcs0
[318.432916] Dynamic subtest bcs0: SUCCESS (21.225s)
[318.481960] Starting dynamic subtest: vcs0
[339.214879] Dynamic subtest vcs0: SUCCESS (20.782s)
[339.260971] Starting dynamic subtest: vecs0
[360.090027] Dynamic subtest vecs0: SUCCESS (20.875s)
[360.108846] Subtest wide: SUCCESS (83.472s)
[361.107165] [083/142] (680s left) vgem_slow (nohang)
[361.412763] Starting subtest: nohang
[371.661639] Subtest nohang: SUCCESS (10.100s)
[371.754554] [084/142] (670s left) kms_content_protection (dp-mst-lic-type-0)
[372.197430] Starting subtest: dp-mst-lic-type-0
[372.238312] Subtest dp-mst-lic-type-0: SKIP (0.001s)
[372.347293] [085/142] (669s left) gem_caching (read-writes)
[372.655449] Starting subtest: read-writes
[398.751073] Subtest read-writes: SUCCESS (26.106s)
[398.932672] [086/142] (643s left) v3d/v3d_wait_bo (unused-bo-0ns)
[399.286890] Subtest unused-bo-0ns: SKIP (0.000s)
[399.387752] [087/142] (643s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[399.841146] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[399.885070] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[400.010039] [088/142] (642s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[400.460873] Starting subtest: fbc-rgb565-draw-blt
[402.618040] Subtest fbc-rgb565-draw-blt: SUCCESS (2.237s)
[402.795007] [089/142] (639s left) kms_chamelium_audio (hdmi-audio)
[403.297451] Subtest hdmi-audio: SKIP (0.000s)
[403.620667] [090/142] (639s left) drm_fdinfo (basics)
[403.926534] Starting subtest: basics
[403.946370] Subtest basics: SUCCESS (0.000s)
[404.062279] [091/142] (638s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[404.415450] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[404.437797] Starting dynamic subtest: pipe-A-valid-mode
[405.154327] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.722s)
[405.174411] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.726s)
[405.526508] [092/142] (637s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt)
[405.950996] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt
[405.990654] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[406.115438] [093/142] (637s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs)
[406.642743] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs
[406.681224] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[407.212245] [094/142] (636s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[407.637524] Starting subtest: fbc-rgb565-draw-mmap-cpu
[409.748010] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.169s)
[409.945443] [095/142] (633s left) gem_exercise_blt (fast-copy)
[410.256877] Starting subtest: fast-copy
[410.276520] Starting dynamic subtest: linear-smem-smem
[410.316966] Dynamic subtest linear-smem-smem: SUCCESS (0.070s)
[410.365046] Starting dynamic subtest: ymajor-smem-smem
[410.387090] Dynamic subtest ymajor-smem-smem: SUCCESS (0.051s)
[410.435893] Starting dynamic subtest: yfmajor-smem-smem
[410.459289] Dynamic subtest yfmajor-smem-smem: SUCCESS (0.049s)
[410.502865] Starting dynamic subtest: tile64-smem-smem
[410.522350] Dynamic subtest tile64-smem-smem: SUCCESS (0.050s)
[410.541661] Subtest fast-copy: SUCCESS (0.229s)
[410.660362] [096/142] (632s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[411.075894] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[411.114619] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[411.242683] [097/142] (632s left) kms_cursor_crc (cursor-offscreen-512x170)
[411.641828] Starting subtest: cursor-offscreen-512x170
[411.680053] Subtest cursor-offscreen-512x170: SKIP (0.003s)
[411.802072] [098/142] (631s left) v3d/v3d_get_bo_offset (create-get-offsets)
[412.161166] Subtest create-get-offsets: SKIP (0.000s)
[412.282400] [099/142] (631s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[412.592947] Starting subtest: tiled-to-tiled
[412.717014] Subtest tiled-to-tiled: SUCCESS (0.114s)
[412.837350] [100/142] (631s left) gem_exec_fair (basic-deadline)
[413.334782] Starting subtest: basic-deadline
[417.384762] Subtest basic-deadline: FAIL (2.480s)
[417.506661] [101/142] (626s left) gem_userptr_blits (input-checking)
[417.884159] Starting subtest: input-checking
[417.903734] Subtest input-checking: SUCCESS (0.000s)
[418.021085] [102/142] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[418.461659] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[418.499984] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[418.623264] [103/142] (625s left) gem_reg_read (bad-register)
[418.921932] Starting subtest: bad-register
[418.943961] Subtest bad-register: SUCCESS (0.000s)
[419.041025] [104/142] (625s left) gem_ctx_persistence (legacy-engines-queued)
[419.347737] Starting subtest: legacy-engines-queued
[419.367916] Starting dynamic subtest: render
[419.387725] Dynamic subtest render: SUCCESS (0.052s)
[419.430048] Starting dynamic subtest: bsd
[419.449398] Dynamic subtest bsd: SUCCESS (0.060s)
[419.494838] Starting dynamic subtest: blt
[419.597185] Dynamic subtest blt: SUCCESS (0.154s)
[419.640559] Starting dynamic subtest: vebox
[419.659978] Dynamic subtest vebox: SUCCESS (0.053s)
[419.679516] Subtest legacy-engines-queued: SUCCESS (0.333s)
[419.779331] [105/142] (624s left) kms_vblank (pipe-c-query-idle-hang)
[420.157632] Starting subtest: pipe-C-query-idle-hang
[427.385946] Subtest pipe-C-query-idle-hang: SUCCESS (7.114s)
[427.652980] [106/142] (616s left) gem_media_fill (media-fill)
[427.958174] Starting subtest: media-fill
[427.976873] Starting dynamic subtest: smem
[427.995546] Dynamic subtest smem: SUCCESS (0.010s)
[428.014046] Subtest media-fill: SUCCESS (0.013s)
[428.218558] [107/142] (616s left) kms_vrr (flip-suspend)
[428.588054] Starting subtest: flip-suspend
[428.628255] Subtest flip-suspend: SKIP (0.000s)
[428.749341] [108/142] (616s left) api_intel_allocator (open-vm)
[429.050737] Starting subtest: open-vm
[429.071700] Subtest open-vm: SUCCESS (0.004s)
[429.165071] [109/142] (615s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_mc_ccs)
[429.829625] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs
[429.867369] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[430.274605] [110/142] (614s left) kms_hdmi_inject (inject-4k)
[430.597387] Subtest inject-4k: SKIP (0.000s)
[430.715901] [111/142] (614s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[431.299375] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[431.337355] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[431.806171] [112/142] (613s left) gem_exec_schedule (noreorder-priority)
[432.258300] Starting subtest: noreorder-priority
[432.279016] Starting dynamic subtest: rcs0
[433.357699] Dynamic subtest rcs0: SUCCESS (1.128s)
[433.405172] Starting dynamic subtest: bcs0
[434.494658] Dynamic subtest bcs0: SUCCESS (1.132s)
[434.542735] Starting dynamic subtest: vcs0
[435.617428] Dynamic subtest vcs0: SUCCESS (1.122s)
[435.663918] Starting dynamic subtest: vecs0
[436.746388] Dynamic subtest vecs0: SUCCESS (1.123s)
[436.767001] Subtest noreorder-priority: SUCCESS (4.518s)
[436.974256] [113/142] (608s left) i915_pm_rpm (system-suspend-modeset)
[439.004414] Starting subtest: system-suspend-modeset
[457.195048] Subtest system-suspend-modeset: SUCCESS (2.107s)
[462.506911] [114/142] (603s left) syncobj_wait (wait-any-interrupted)
[462.812732] Starting subtest: wait-any-interrupted
[462.890470] Subtest wait-any-interrupted: SUCCESS (0.106s)
[463.013123] [115/142] (603s left) kms_flip (2x-flip-vs-suspend-interruptible)
[463.386535] Starting subtest: 2x-flip-vs-suspend-interruptible
[463.424034] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.003s)
[463.546003] [116/142] (602s left) gem_exec_fence (submit3)
[463.971682] Starting subtest: submit3
[463.992170] Starting dynamic subtest: rcs0
[464.012120] Dynamic subtest rcs0: SUCCESS (0.013s)
[464.054152] Starting dynamic subtest: bcs0
[464.073013] Dynamic subtest bcs0: SUCCESS (0.013s)
[464.115952] Starting dynamic subtest: vcs0
[464.137727] Dynamic subtest vcs0: SUCCESS (0.010s)
[464.185564] Starting dynamic subtest: vecs0
[464.206209] Dynamic subtest vecs0: SUCCESS (0.010s)
[464.226425] Subtest submit3: SUCCESS (0.058s)
[464.724271] [117/142] (601s left) v3d/v3d_job_submission (array-job-submission)
[465.076185] Subtest array-job-submission: SKIP (0.000s)
[465.170426] [118/142] (601s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_ccs)
[465.900900] Subtest pipe-D-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[466.243602] [119/142] (600s left) gen9_exec_parse (allowed-all)
[466.550248] Starting subtest: allowed-all
[466.568655] Subtest allowed-all: SUCCESS (0.003s)
[466.844282] [120/142] (599s left) gem_create (create-ext-set-pat)
[467.256149] Starting subtest: create-ext-set-pat
[467.293866] Subtest create-ext-set-pat: SKIP (0.000s)
[467.409938] [121/142] (599s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-signaled)
[467.701749] Starting subtest: invalid-multi-wait-all-available-unsubmitted-signaled
[467.722002] Subtest invalid-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.001s)
[467.823046] [122/142] (599s left) syncobj_timeline (wait-all-interrupted)
[468.115772] Starting subtest: wait-all-interrupted
[468.196779] Subtest wait-all-interrupted: SUCCESS (0.109s)
[468.322050] [123/142] (598s left) kms_lease (invalid-create-leases)
[468.694700] Starting subtest: invalid-create-leases
[468.716423] Subtest invalid-create-leases: SUCCESS (0.007s)
[468.848544] [124/142] (598s left) syncobj_wait (reset-unsignaled)
[469.146013] Starting subtest: reset-unsignaled
[469.165850] Subtest reset-unsignaled: SUCCESS (0.000s)
[469.259211] [125/142] (598s left) kms_busy (extended-pageflip-hang-oldfb)
[469.634482] Starting subtest: extended-pageflip-hang-oldfb
[469.656059] Starting dynamic subtest: pipe-A
[470.091927] Dynamic subtest pipe-A: SUCCESS (0.459s)
[470.134864] Starting dynamic subtest: pipe-C
[470.707406] Dynamic subtest pipe-C: SUCCESS (0.615s)
[470.728794] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.087s)
[471.151951] [126/142] (596s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_mc_ccs)
[471.794037] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs
[471.833321] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[472.255214] [127/142] (595s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_ccs)
[472.981774] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_ccs
[473.023941] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.004s)
[473.368234] [128/142] (594s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[473.739378] Starting subtest: cursor-vs-flip-atomic
[511.720998] Subtest cursor-vs-flip-atomic: SUCCESS (37.968s)
[512.098060] [129/142] (555s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[512.673444] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[512.711576] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[513.208499] [130/142] (554s left) kms_plane_scaling (planes-scaler-unity-scaling)
[513.580086] Starting subtest: planes-scaler-unity-scaling
[513.598947] Starting dynamic subtest: pipe-A-DP-1
[513.693004] Dynamic subtest pipe-A-DP-1: SUCCESS (0.102s)
[513.737693] Starting dynamic subtest: pipe-B-DP-1
[514.107625] Dynamic subtest pipe-B-DP-1: SUCCESS (0.402s)
[514.172596] Starting dynamic subtest: pipe-C-DP-1
[514.476050] Dynamic subtest pipe-C-DP-1: SUCCESS (0.386s)
[514.494879] Subtest planes-scaler-unity-scaling: SUCCESS (0.905s)
[514.923263] [131/142] (553s left) gem_exec_reloc (basic-write-cpu-active)
[515.230126] Starting subtest: basic-write-cpu-active
[515.349156] Subtest basic-write-cpu-active: SUCCESS (0.139s)
[515.590864] [132/142] (552s left) core_setmaster (master-drop-set-root)
[517.739654] Starting subtest: master-drop-set-root
[517.788618] Subtest master-drop-set-root: SUCCESS (0.010s)
[517.903478] [133/142] (550s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[518.356006] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[518.394051] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[518.509035] [134/142] (549s left) gem_pwrite (basic-self)
[518.809537] Starting subtest: basic-self
[519.040183] Subtest basic-self: SUCCESS (0.255s)
[519.189310] [135/142] (549s left) i915_pm_rpm (gem-execbuf)
[521.045179] Starting subtest: gem-execbuf
[521.065469] Starting dynamic subtest: smem0
[522.686829] Dynamic subtest smem0: SUCCESS (1.633s)
[522.705996] Subtest gem-execbuf: SUCCESS (1.636s)
[523.241747] [136/142] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[523.704034] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[523.757543] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[523.912709] [137/142] (544s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[524.427612] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[524.479630] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[525.076748] [138/142] (543s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[529.483667] Subtest parallel-dmabuf-import-out-fence: SKIP (0.000s)
[529.584556] [139/142] (539s left) gem_exec_parallel (fds)
[529.886650] Starting subtest: fds
[529.908257] Starting dynamic subtest: rcs0
[534.392928] Dynamic subtest rcs0: SUCCESS (4.512s)
[534.436711] Starting dynamic subtest: bcs0
[539.931198] Dynamic subtest bcs0: SUCCESS (5.363s)
[539.977422] Starting dynamic subtest: vcs0
[545.263029] Dynamic subtest vcs0: SUCCESS (5.340s)
[545.305288] Starting dynamic subtest: vecs0
[549.498431] Dynamic subtest vecs0: SUCCESS (4.392s)
[549.517378] Subtest fds: SUCCESS (19.618s)
[549.764501] [140/142] (519s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[550.212435] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[550.252059] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[550.370566] [141/142] (518s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[550.753309] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[550.772205] Starting dynamic subtest: A-DP1
[552.001606] Dynamic subtest A-DP1: SUCCESS (1.267s)
[552.047176] Starting dynamic subtest: B-DP1
[553.199208] Dynamic subtest B-DP1: SUCCESS (1.202s)
[553.278733] Starting dynamic subtest: C-DP1
[554.373535] Dynamic subtest C-DP1: SUCCESS (1.155s)
[554.393947] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.638s)
[554.776246] [142/142] (514s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[555.573658] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[555.895756] Closing watchdogs
Done.