[41.919813] Initializing watchdogs
[41.919867]   /dev/watchdog0
[41.923995] [001/137] (960s left) gem_close_race (multigpu-basic-threads)
[41.976515] Starting subtest: multigpu-basic-threads
[41.977837] Subtest multigpu-basic-threads: SKIP (0.000s)
[42.153850] [002/137] (960s left) kms_ccs (pipe-b-bad-pixel-format-yf_tiled_ccs)
[42.349699] Starting subtest: pipe-B-bad-pixel-format-yf_tiled_ccs
[42.351041] Subtest pipe-B-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[42.500821] [003/137] (959s left) kms_setmode (basic)
[42.540323] Starting subtest: basic
[42.654530] Starting dynamic subtest: pipe-A-HDMI-A-2
[45.000629] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.343s)
[45.076964] Starting dynamic subtest: pipe-B-HDMI-A-2
[47.418808] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.341s)
[47.460827] Subtest basic: SUCCESS (4.920s)
[47.570031] [004/137] (954s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs)
[47.812746] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[47.894623] [005/137] (954s left) kms_atomic (plane-immutable-zpos)
[48.006258] Starting subtest: plane-immutable-zpos
[48.340744] Subtest plane-immutable-zpos: SUCCESS (0.334s)
[48.488105] [006/137] (953s left) gem_mmap (basic)
[48.527460] Starting subtest: basic
[48.530707] Subtest basic: SUCCESS (0.000s)
[48.620600] [007/137] (953s left) kms_frontbuffer_tracking (psr-slowdraw)
[48.718975] Starting subtest: psr-slowdraw
[48.720550] Subtest psr-slowdraw: SKIP (0.000s)
[48.813109] [008/137] (953s left) kms_async_flips (test-cursor)
[48.901136] Starting subtest: test-cursor
[48.901832] Starting dynamic subtest: pipe-A-HDMI-A-2
[49.608104] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.707s)
[49.610965] Starting dynamic subtest: pipe-B-HDMI-A-2
[50.268176] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.660s)
[50.268863] Subtest test-cursor: SUCCESS (1.368s)
[50.732637] [009/137] (951s left) gen7_exec_parse (load-register-reg)
[50.774599] Subtest load-register-reg: SKIP (0.000s)
[50.784917] [010/137] (951s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[50.824493] Starting subtest: invalid-bsd2-flag-on-vebox
[50.825183] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[50.903295] [011/137] (951s left) gem_lmem_swapping (heavy-verify-multi)
[50.943864] Subtest heavy-verify-multi: SKIP (0.000s)
[50.955404] [012/137] (951s left) gem_ctx_shared (create-shared-gtt)
[50.997125] Starting subtest: create-shared-gtt
[53.146858] Subtest create-shared-gtt: SUCCESS (2.149s)
[53.329130] [013/137] (949s left) perf_pmu (most-busy-idle-check-all)
[53.384195] Starting subtest: most-busy-idle-check-all
[53.385035] Starting dynamic subtest: rcs0
[53.998249] Dynamic subtest rcs0: SUCCESS (0.614s)
[54.005121] Starting dynamic subtest: bcs0
[54.615279] Dynamic subtest bcs0: SUCCESS (0.617s)
[54.622728] Starting dynamic subtest: vcs0
[55.231335] Dynamic subtest vcs0: SUCCESS (0.616s)
[55.238120] Starting dynamic subtest: vecs0
[55.845245] Dynamic subtest vecs0: SUCCESS (0.614s)
[55.846471] Subtest most-busy-idle-check-all: SUCCESS (2.461s)
[55.925322] [014/137] (946s left) kms_plane_alpha_blend (constant-alpha-min)
[56.012650] Starting subtest: constant-alpha-min
[56.074956] Starting dynamic subtest: pipe-A-HDMI-A-2
[56.800222] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.724s)
[56.804728] Starting dynamic subtest: pipe-B-HDMI-A-2
[57.527080] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.725s)
[57.527826] Subtest constant-alpha-min: SUCCESS (1.516s)
[57.639456] [015/137] (944s left) kms_flip (flip-vs-fences-interruptible)
[57.708803] Starting subtest: flip-vs-fences-interruptible
[57.709623] Starting dynamic subtest: A-HDMI-A2
[72.911345] Dynamic subtest A-HDMI-A2: SUCCESS (15.201s)
[72.918868] Starting dynamic subtest: B-HDMI-A2
[88.039036] Dynamic subtest B-HDMI-A2: SUCCESS (15.127s)
[88.039787] Subtest flip-vs-fences-interruptible: SUCCESS (30.331s)
[88.166686] [016/137] (914s left) kms_content_protection (dp-mst-type-1)
[88.244716] Starting subtest: dp-mst-type-1
[88.246171] Subtest dp-mst-type-1: SKIP (0.000s)
[88.353609] [017/137] (914s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[88.449274] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[90.397322] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (1.950s)
[90.550951] [018/137] (912s left) vgem_basic (bad-fence)
[90.642622] Starting subtest: bad-fence
[90.643645] Subtest bad-fence: SUCCESS (0.000s)
[90.706378] [019/137] (911s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[90.973092] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[91.055207] [020/137] (911s left) prime_mmap_coherency (write)
[91.096451] Starting subtest: write
[96.469557] Subtest write: SUCCESS (5.373s)
[96.696317] [021/137] (905s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[96.771972] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[96.773413] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[96.872500] [022/137] (905s left) gem_exec_fence (nb-await)
[97.049702] Starting subtest: nb-await
[97.051072] Starting dynamic subtest: rcs0
[97.117391] Dynamic subtest rcs0: SUCCESS (0.067s)
[97.125452] Starting dynamic subtest: bcs0
[97.177375] Dynamic subtest bcs0: SUCCESS (0.060s)
[97.189929] Starting dynamic subtest: vcs0
[97.240199] Dynamic subtest vcs0: SUCCESS (0.063s)
[97.252121] Starting dynamic subtest: vecs0
[97.302692] Dynamic subtest vecs0: SUCCESS (0.062s)
[97.303876] Subtest nb-await: SUCCESS (0.253s)
[97.748638] [023/137] (904s left) syncobj_timeline (invalid-transfer-bad-pad)
[97.801842] Starting subtest: invalid-transfer-bad-pad
[97.802534] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[97.883513] [024/137] (904s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_mc_ccs)
[98.135148] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[98.218105] [025/137] (904s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_mc_ccs)
[98.293161] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs
[98.294615] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[98.545035] [026/137] (904s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[98.586419] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[98.688944] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s)
[98.758404] [027/137] (903s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[98.805624] Starting subtest: invalid-multi-wait-all-unsubmitted
[98.806374] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[98.882236] [028/137] (903s left) kms_writeback (writeback-pixel-formats)
[99.000619] Subtest writeback-pixel-formats: SKIP (0.000s)
[99.014671] [029/137] (903s left) syncobj_wait (single-wait-all-submitted)
[99.055908] Starting subtest: single-wait-all-submitted
[99.161613] Subtest single-wait-all-submitted: SUCCESS (0.106s)
[99.244230] [030/137] (903s left) kms_big_fb (linear-64bpp-rotate-90)
[99.337018] Starting subtest: linear-64bpp-rotate-90
[99.379368] Subtest linear-64bpp-rotate-90: SKIP (0.041s)
[99.453961] [031/137] (903s left) drm_fdinfo (virtual-idle)
[99.494718] Starting subtest: virtual-idle
[100.029913] Subtest virtual-idle: FAIL (0.523s)
[100.098549] [032/137] (902s left) kms_psr (primary_mmap_gtt)
[100.149366] Subtest primary_mmap_gtt: SKIP (0.000s)
[100.170428] [033/137] (902s left) gem_ctx_persistence (engines-mixed-process)
[100.221904] Starting subtest: engines-mixed-process
[100.222661] Starting dynamic subtest: rcs0
[100.566278] Dynamic subtest rcs0: SUCCESS (0.344s)
[100.570560] Starting dynamic subtest: bcs0
[100.879088] Dynamic subtest bcs0: SUCCESS (0.313s)
[100.882748] Starting dynamic subtest: vcs0
[101.211999] Dynamic subtest vcs0: SUCCESS (0.333s)
[101.215705] Starting dynamic subtest: vecs0
[101.510082] Dynamic subtest vecs0: SUCCESS (0.298s)
[101.510967] Subtest engines-mixed-process: SUCCESS (1.288s)
[101.611821] [034/137] (901s left) gem_ctx_exec (basic-nohangcheck)
[101.666275] Starting subtest: basic-nohangcheck
[102.818864] Subtest basic-nohangcheck: FAIL (1.118s)
[102.850780] [035/137] (900s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[102.896370] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[102.897066] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[102.960476] [036/137] (899s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[103.020243] Starting subtest: x-tiled-to-vebox-yf-tiled
[103.020965] Starting dynamic subtest: smem
[103.089319] Dynamic subtest smem: SUCCESS (0.069s)
[103.089998] Subtest x-tiled-to-vebox-yf-tiled: SUCCESS (0.069s)
[103.268385] [037/137] (899s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[103.363052] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[103.364401] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[103.476408] [038/137] (899s left) gem_fence_thrash (bo-copy)
[103.531218] Starting subtest: bo-copy
[104.941047] Subtest bo-copy: SUCCESS (1.410s)
[105.032730] [039/137] (897s left) api_intel_bb (offset-control)
[105.123789] Starting subtest: offset-control
[105.126672] Subtest offset-control: SUCCESS (0.003s)
[105.240492] [040/137] (897s left) api_intel_allocator (two-level-inception-interruptible)
[105.296503] Starting subtest: two-level-inception-interruptible
[110.694374] Subtest two-level-inception-interruptible: SUCCESS (5.397s)
[110.781969] [041/137] (892s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs)
[110.925129] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs
[110.926476] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[111.108368] [042/137] (891s left) kms_fence_pin_leak
[112.769718] [043/137] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[112.846537] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[115.264764] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.420s)
[115.401158] [044/137] (887s left) gem_mmap_gtt (isolation)
[115.452350] Starting subtest: isolation
[115.454301] Subtest isolation: SUCCESS (0.001s)
[115.558580] [045/137] (887s left) kms_cursor_crc (cursor-offscreen-max-size)
[115.647666] Starting subtest: cursor-offscreen-max-size
[115.650313] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[115.737065] [046/137] (887s left) gem_exec_reloc (basic-cpu-noreloc)
[115.796258] Subtest basic-cpu-noreloc: SKIP (0.000s)
[115.844843] [047/137] (887s left) kms_force_connector_basic (force-connector-state)
[115.953720] Starting subtest: force-connector-state
[116.720468] Subtest force-connector-state: SUCCESS (0.768s)
[117.044719] [048/137] (886s left) kms_cursor_crc (cursor-onscreen-512x170)
[117.121116] Starting subtest: cursor-onscreen-512x170
[117.122485] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[117.196398] [049/137] (885s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-a)
[117.268777] Starting subtest: universal-plane-pageflip-windowed-pipe-A
[117.743364] Subtest universal-plane-pageflip-windowed-pipe-A: SUCCESS (0.475s)
[117.835039] [050/137] (885s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[118.077033] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[118.160124] [051/137] (884s left) gem_softpin (noreloc-s3)
[118.200119] Starting subtest: noreloc-S3
[135.744076] Subtest noreloc-S3: SUCCESS (17.544s)
[140.886956] [052/137] (867s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[141.114410] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[141.115771] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[141.244076] [053/137] (866s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[141.319893] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[141.321250] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[141.395618] [054/137] (866s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[141.481682] Starting subtest: primary-yf-tiled-reflect-x-0
[141.595356] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.112s)
[141.680482] [055/137] (866s left) kms_vblank (pipe-b-query-busy)
[141.767659] Starting subtest: pipe-B-query-busy
[144.780209] Subtest pipe-B-query-busy: SUCCESS (3.012s)
[144.889980] [056/137] (863s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[144.956650] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[145.021090] [057/137] (863s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[145.113461] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[145.114810] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[145.211468] [058/137] (863s left) perf_pmu (busy-idle-check-all)
[145.266373] Starting subtest: busy-idle-check-all
[145.267089] Starting dynamic subtest: rcs0
[145.884333] Dynamic subtest rcs0: SUCCESS (0.617s)
[145.892325] Starting dynamic subtest: bcs0
[146.505342] Dynamic subtest bcs0: SUCCESS (0.620s)
[146.512912] Starting dynamic subtest: vcs0
[147.125482] Dynamic subtest vcs0: SUCCESS (0.620s)
[147.132876] Starting dynamic subtest: vecs0
[147.745936] Dynamic subtest vecs0: SUCCESS (0.620s)
[147.747421] Subtest busy-idle-check-all: SUCCESS (2.479s)
[147.824425] [059/137] (860s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[147.902687] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[147.904028] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[148.002242] [060/137] (860s left) gem_userptr_blits (stress-mm)
[148.062960] Starting subtest: stress-mm
[153.433424] Subtest stress-mm: SUCCESS (5.370s)
[153.542335] [061/137] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[153.624604] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[153.625997] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[153.726814] [062/137] (854s left) gem_spin_batch (spin-all)
[153.785935] Starting subtest: spin-all
[153.790543] Subtest spin-all: SUCCESS (0.005s)
[153.965094] [063/137] (854s left) syncobj_timeline (wait-any-complex)
[154.026722] Starting subtest: wait-any-complex
[154.087876] Subtest wait-any-complex: SUCCESS (0.061s)
[154.160672] [064/137] (854s left) kms_display_modes (extended-mode-basic)
[154.246889] Starting subtest: extended-mode-basic
[154.248484] Subtest extended-mode-basic: SKIP (0.000s)
[154.258818] [065/137] (854s left) gem_userptr_blits (map-fixed-invalidate)
[154.303072] Starting subtest: map-fixed-invalidate
[154.303760] Starting dynamic subtest: gtt
[154.364881] Dynamic subtest gtt: SUCCESS (0.062s)
[154.369387] Starting dynamic subtest: wb
[154.412526] Dynamic subtest wb: SUCCESS (0.048s)
[154.416893] Starting dynamic subtest: wc
[154.459592] Dynamic subtest wc: SUCCESS (0.047s)
[154.464098] Starting dynamic subtest: uc
[154.507290] Dynamic subtest uc: SUCCESS (0.048s)
[154.507967] Subtest map-fixed-invalidate: SUCCESS (0.204s)
[154.615275] [066/137] (853s left) kms_frontbuffer_tracking (fbcpsr-badstride)
[154.695258] Starting subtest: fbcpsr-badstride
[154.696575] Subtest fbcpsr-badstride: SKIP (0.000s)
[154.793617] [067/137] (853s left) prime_mmap (test_forked)
[154.841064] Starting subtest: test_forked
[154.841751] Starting dynamic subtest: test_forked-smem
[154.897374] Dynamic subtest test_forked-smem: SUCCESS (0.056s)
[154.898086] Subtest test_forked: SUCCESS (0.057s)
[154.996789] [068/137] (853s left) kms_vblank (pipe-b-query-forked)
[155.083718] Starting subtest: pipe-B-query-forked
[157.915146] Subtest pipe-B-query-forked: SUCCESS (2.831s)
[158.031320] [069/137] (850s left) gem_exec_whisper (basic-normal)
[158.075264] Starting subtest: basic-normal
[159.035789] Subtest basic-normal: SUCCESS (0.961s)
[159.228093] [070/137] (849s left) kms_setmode (basic-clone-single-crtc)
[159.271030] Starting subtest: basic-clone-single-crtc
[159.273008] Subtest basic-clone-single-crtc: SKIP (0.000s)
[159.337203] [071/137] (849s left) kms_psr (psr2_cursor_render)
[159.390427] Subtest psr2_cursor_render: SKIP (0.000s)
[159.411512] [072/137] (849s left) core_getclient
[159.526774] [073/137] (848s left) gem_close (many-handles-one-vma)
[159.582153] Starting subtest: many-handles-one-vma
[159.597839] Subtest many-handles-one-vma: SUCCESS (0.016s)
[159.701801] [074/137] (848s left) syncobj_wait (reset-during-wait-for-submit)
[159.747012] Starting subtest: reset-during-wait-for-submit
[159.848893] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[159.922677] [075/137] (848s left) syncobj_wait (single-wait-for-submit-signaled)
[159.971512] Starting subtest: single-wait-for-submit-signaled
[159.972207] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[160.039922] [076/137] (848s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[160.129931] Starting subtest: fbc-rgb101010-draw-pwrite
[162.859359] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.730s)
[162.996685] [077/137] (845s left) gem_request_retire (retire-vma-not-inactive)
[163.043195] Starting subtest: retire-vma-not-inactive
[163.048532] Subtest retire-vma-not-inactive: SUCCESS (0.004s)
[163.147794] [078/137] (845s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[163.400648] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[163.483849] [079/137] (845s left) gem_caching (read-writes)
[163.524031] Starting subtest: read-writes
[173.390518] Subtest read-writes: SUCCESS (9.866s)
[173.500721] [080/137] (835s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[173.647860] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[173.980049] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SUCCESS (0.332s)
[174.215208] [081/137] (834s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[174.324580] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[174.371696] [082/137] (834s left) gem_exec_schedule (preemptive-hang)
[174.540635] Starting subtest: preemptive-hang
[174.541370] Starting dynamic subtest: rcs0
[180.868139] Dynamic subtest rcs0: SUCCESS (6.348s)
[180.874045] Starting dynamic subtest: bcs0
[186.883674] Dynamic subtest bcs0: SUCCESS (6.015s)
[186.890040] Starting dynamic subtest: vcs0
[192.900145] Dynamic subtest vcs0: SUCCESS (6.015s)
[192.905875] Starting dynamic subtest: vecs0
[198.916944] Dynamic subtest vecs0: SUCCESS (6.015s)
[198.918297] Subtest preemptive-hang: SUCCESS (24.396s)
[199.098871] [083/137] (809s left) gem_basic (create-fd-close)
[199.142551] Starting subtest: create-fd-close
[199.144028] Subtest create-fd-close: SUCCESS (0.000s)
[199.250090] [084/137] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[199.339209] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[199.340662] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[199.440215] [085/137] (809s left) sw_sync (alloc_fence)
[199.492957] Starting subtest: alloc_fence
[199.493723] Subtest alloc_fence: SUCCESS (0.000s)
[199.544828] [086/137] (809s left) i915_pm_rpm (sysfs-read)
[200.930595] Starting subtest: sysfs-read
[201.211502] Subtest sysfs-read: SUCCESS (0.279s)
[201.408295] [087/137] (807s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[201.485424] Starting subtest: yf-tiled-16bpp-rotate-180
[201.486921] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[201.597827] [088/137] (807s left) syncobj_timeline (wait-for-submit-complex)
[201.641905] Starting subtest: wait-for-submit-complex
[201.704048] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[201.781103] [089/137] (806s left) i915_pm_backlight (fade-with-suspend)
[201.866868] Subtest fade-with-suspend: SKIP (0.000s)
[201.896768] [090/137] (806s left) v3d/v3d_submit_csd (multi-and-single-sync)
[201.967040] Subtest multi-and-single-sync: SKIP (0.000s)
[202.033556] [091/137] (806s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[202.121486] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[202.122937] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[202.244598] [092/137] (806s left) prime_mmap (test_aperture_limit)
[202.287875] Starting subtest: test_aperture_limit
[202.288613] Starting dynamic subtest: test_aperture_limit-smem
[202.293349] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.005s)
[202.294124] Subtest test_aperture_limit: SUCCESS (0.006s)
[202.395727] [093/137] (806s left) gem_bad_reloc (negative-reloc-lut)
[202.449477] Subtest negative-reloc-lut: SKIP (0.000s)
[202.488696] [094/137] (806s left) gem_exec_balancer (sequential)
[202.546322] Starting subtest: sequential
[203.300781] Subtest sequential: SUCCESS (0.754s)
[204.225694] [095/137] (804s left) gen3_render_mixed_blits
[204.286588] [096/137] (804s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[204.360889] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[204.362890] Starting dynamic subtest: pipe-A-valid-mode
[205.089978] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.728s)
[205.090660] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.729s)
[205.214501] [097/137] (803s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[205.288992] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[205.289722] Starting dynamic subtest: pipe-A-HDMI-A-2
[205.295948] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.006s)
[205.300478] Starting dynamic subtest: pipe-B-HDMI-A-2
[205.311073] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.014s)
[205.312437] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.022s)
[205.385437] [098/137] (803s left) kms_hdr (static-toggle)
[205.457890] Starting subtest: static-toggle
[205.459256] Subtest static-toggle: SKIP (0.000s)
[205.517278] [099/137] (803s left) gem_ppgtt (shrink-vs-evict-pinned)
[205.568859] Starting subtest: shrink-vs-evict-pinned
[210.655311] Subtest shrink-vs-evict-pinned: SUCCESS (5.085s)
[210.724852] [100/137] (798s left) kms_cursor_crc (cursor-sliding-512x170)
[210.811664] Starting subtest: cursor-sliding-512x170
[210.813033] Subtest cursor-sliding-512x170: SKIP (0.001s)
[210.908067] [101/137] (798s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[210.999917] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[211.001306] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[211.122444] [102/137] (797s left) gem_exec_balancer (full-late)
[211.182835] Starting subtest: full-late
[212.244750] Subtest full-late: SUCCESS (1.062s)
[213.175352] [103/137] (795s left) gem_exec_schedule (independent)
[213.224589] Starting subtest: independent
[213.225242] Starting dynamic subtest: rcs0
[213.313890] Dynamic subtest rcs0: SUCCESS (0.089s)
[213.322842] Starting dynamic subtest: bcs0
[213.402077] Dynamic subtest bcs0: SUCCESS (0.087s)
[213.416989] Starting dynamic subtest: vcs0
[213.502947] Dynamic subtest vcs0: SUCCESS (0.100s)
[213.518904] Starting dynamic subtest: vecs0
[213.591018] Dynamic subtest vecs0: SUCCESS (0.087s)
[213.592219] Subtest independent: SUCCESS (0.366s)
[213.885991] [104/137] (795s left) i915_fb_tiling
[214.031554] [105/137] (794s left) i915_pm_lpsp (kms-lpsp)
[215.120974] Starting subtest: kms-lpsp
[215.121758] Starting dynamic subtest: kms-lpsp-HDMI-A
[215.123192] Dynamic subtest kms-lpsp-HDMI-A: SKIP (0.000s)
[215.124501] Subtest kms-lpsp: SKIP (0.000s)
[215.264242] [106/137] (793s left) v3d/v3d_submit_cl (bad-multisync-out-sync)
[215.335953] Subtest bad-multisync-out-sync: SKIP (0.000s)
[215.402146] [107/137] (793s left) kms_plane (pixel-format-source-clamping)
[215.485545] Starting subtest: pixel-format-source-clamping
[215.486338] Starting dynamic subtest: pipe-A-planes
[226.478480] Dynamic subtest pipe-A-planes: SUCCESS (10.993s)
[226.484903] Starting dynamic subtest: pipe-B-planes
[237.434573] Dynamic subtest pipe-B-planes: SUCCESS (10.953s)
[237.435282] Subtest pixel-format-source-clamping: SUCCESS (21.950s)
[237.549940] [108/137] (771s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[237.659475] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[237.707058] [109/137] (771s left) kms_flip (bo-too-big)
[237.776017] Starting subtest: bo-too-big
[237.776777] Starting dynamic subtest: A-HDMI-A2
[238.199427] Dynamic subtest A-HDMI-A2: SUCCESS (0.423s)
[238.215526] Starting dynamic subtest: B-HDMI-A2
[238.584959] Dynamic subtest B-HDMI-A2: SUCCESS (0.384s)
[238.586062] Subtest bo-too-big: SUCCESS (0.811s)
[238.735910] [110/137] (770s left) kms_flip (plain-flip-ts-check)
[238.803600] Starting subtest: plain-flip-ts-check
[238.805536] Starting dynamic subtest: A-HDMI-A2
[254.325162] Dynamic subtest A-HDMI-A2: SUCCESS (15.520s)
[254.332939] Starting dynamic subtest: B-HDMI-A2
[269.796482] Dynamic subtest B-HDMI-A2: SUCCESS (15.470s)
[269.797515] Subtest plain-flip-ts-check: SUCCESS (30.994s)
[269.926145] [111/137] (739s left) gem_exec_fair (basic-none-solo)
[269.971427] Starting subtest: basic-none-solo
[269.972104] Starting dynamic subtest: rcs0
[277.803527] Dynamic subtest rcs0: FAIL (7.809s)
[277.804685] Subtest basic-none-solo: FAIL (7.809s)
[277.971745] [112/137] (731s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[278.059941] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[278.061272] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[278.161144] [113/137] (730s left) gem_exec_schedule (wide)
[278.329790] Starting subtest: wide
[278.331181] Starting dynamic subtest: rcs0
[294.481978] Dynamic subtest rcs0: SUCCESS (16.151s)
[294.487497] Starting dynamic subtest: bcs0
[303.666974] Dynamic subtest bcs0: SUCCESS (9.185s)
[303.671809] Starting dynamic subtest: vcs0
[320.717553] Dynamic subtest vcs0: SUCCESS (17.050s)
[320.723697] Starting dynamic subtest: vecs0
[330.189819] Dynamic subtest vecs0: SUCCESS (9.472s)
[330.190528] Subtest wide: SUCCESS (51.861s)
[331.307110] [114/137] (677s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[331.390566] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[331.392033] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[331.495259] [115/137] (677s left) gem_ctx_param (basic-default)
[331.549235] Starting subtest: basic-default
[331.550020] Subtest basic-default: SUCCESS (0.000s)
[331.626494] [116/137] (677s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[331.679850] Starting subtest: basic-write-cpu-read-gtt
[331.882672] Subtest basic-write-cpu-read-gtt: SUCCESS (0.203s)
[331.975171] [117/137] (677s left) kms_chamelium_color (ctm-0-50)
[332.063912] Subtest ctm-0-50: SKIP (0.000s)
[332.078546] [118/137] (677s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[332.157022] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[333.381257] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.224s)
[333.520267] [119/137] (675s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[333.602823] Starting subtest: flip-vs-cursor-toggle
[342.209108] Subtest flip-vs-cursor-toggle: SUCCESS (8.606s)
[342.304374] [120/137] (666s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[342.345474] Starting subtest: invalid-bsd1-flag-on-vebox
[342.346187] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[342.424330] [121/137] (666s left) syncobj_wait (wait-for-submit-snapshot)
[342.478907] Starting subtest: wait-for-submit-snapshot
[342.560368] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[342.646588] [122/137] (666s left) kms_scaling_modes (scaling-mode-center)
[342.729958] Starting subtest: scaling-mode-center
[342.731339] Subtest scaling-mode-center: SKIP (0.000s)
[342.809221] [123/137] (666s left) kms_vblank (pipe-a-wait-forked)
[342.887110] Starting subtest: pipe-A-wait-forked
[345.466694] Subtest pipe-A-wait-forked: SUCCESS (2.580s)
[345.574251] [124/137] (663s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[345.648140] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[345.648826] Starting dynamic subtest: pipe-A-valid-mode
[346.329688] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.681s)
[346.330369] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SUCCESS (0.682s)
[346.451825] [125/137] (662s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[346.526034] Starting subtest: cursorA-vs-flipA-varying-size
[357.374380] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.849s)
[357.479918] [126/137] (651s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[357.557161] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[357.557988] Starting dynamic subtest: pipe-A-valid-mode
[357.606612] Dynamic subtest pipe-A-valid-mode: SKIP (0.049s)
[357.608017] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.051s)
[357.690752] [127/137] (651s left) kms_lease (lessee_list)
[357.765247] Starting subtest: lessee_list
[357.765976] Starting dynamic subtest: pipe-A-HDMI-A-2
[357.771665] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[357.776397] Starting dynamic subtest: pipe-B-HDMI-A-2
[357.777084] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s)
[357.777766] Subtest lessee_list: SUCCESS (0.003s)
[357.826785] [128/137] (651s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[357.883233] Starting subtest: y-tiled-to-vebox-y-tiled
[357.883946] Starting dynamic subtest: smem
[358.011446] Dynamic subtest smem: SUCCESS (0.120s)
[358.012164] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.120s)
[358.188452] [129/137] (651s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[358.240372] Starting subtest: multi-wait-all-for-submit-available-submitted
[358.241077] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[358.316962] [130/137] (651s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[358.406085] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[358.407415] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[358.509212] [131/137] (650s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[358.600064] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[358.601457] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[358.698962] [132/137] (650s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[358.780699] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[358.849337] [133/137] (650s left) i915_suspend (debugfs-reader)
[358.902532] Starting subtest: debugfs-reader
[377.713650] Subtest debugfs-reader: SUCCESS (18.812s)
[381.746155] [134/137] (631s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[381.829998] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[381.831331] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[381.927135] [135/137] (631s left) gem_mmap_gtt (cpuset-medium-copy)
[381.971068] Starting subtest: cpuset-medium-copy
[390.018448] Subtest cpuset-medium-copy: SUCCESS (8.047s)
[390.115852] [136/137] (623s left) kms_prop_blob (invalid-get-prop)
[390.201761] Starting subtest: invalid-get-prop
[390.202423] Subtest invalid-get-prop: SUCCESS (0.000s)
[390.272209] [137/137] (623s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[390.368629] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[390.755711] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.387s)
[390.912463] Closing watchdogs
Done.