[61.230097] Initializing watchdogs
[61.230152]   /dev/watchdog0
[61.234349] [001/137] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[61.328784] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[61.330173] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[61.404014] [002/137] (960s left) kms_vblank (pipe-c-accuracy-idle)
[61.498042] Subtest pipe-C-accuracy-idle: SKIP (0.000s)
[61.555559] [003/137] (960s left) kms_invalid_mode (zero-vdisplay)
[61.642474] Starting subtest: zero-vdisplay
[61.643178] Starting dynamic subtest: HDMI-A-1-pipe-A
[61.694067] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.052s)
[61.697714] Starting dynamic subtest: HDMI-A-1-pipe-B
[61.703902] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.009s)
[61.704580] Subtest zero-vdisplay: SUCCESS (0.063s)
[61.824785] [004/137] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[61.911709] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[61.913043] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[61.996098] [005/137] (959s left) kms_psr (primary_mmap_gtt)
[62.051221] Subtest primary_mmap_gtt: SKIP (0.000s)
[62.069967] [006/137] (959s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[62.159436] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[65.155660] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.998s)
[65.283223] [007/137] (956s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[65.392430] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[65.393749] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[65.467346] [008/137] (956s left) gem_ctx_isolation (preservation-s3)
[65.522819] Starting subtest: preservation-S3
[65.523522] Starting dynamic subtest: rcs0
[82.642266] Dynamic subtest rcs0: SUCCESS (17.119s)
[82.645838] Starting dynamic subtest: bcs0
[99.660969] Dynamic subtest bcs0: SUCCESS (17.019s)
[99.664684] Starting dynamic subtest: vcs0
[116.614652] Dynamic subtest vcs0: SUCCESS (16.954s)
[116.619025] Starting dynamic subtest: vecs0
[133.615299] Dynamic subtest vecs0: SUCCESS (17.001s)
[133.615999] Subtest preservation-S3: SUCCESS (68.092s)
[137.811948] [009/137] (888s left) perf (gen12-group-concurrent-oa-buffer-read)
[137.936699] Subtest gen12-group-concurrent-oa-buffer-read: SKIP (0.000s)
[137.958230] [010/137] (887s left) syncobj_timeline (etime-multi-wait-submitted)
[137.999396] Starting subtest: etime-multi-wait-submitted
[138.105362] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[138.169721] [011/137] (887s left) gem_userptr_blits (invalid-null-pointer)
[138.224592] Starting subtest: invalid-null-pointer
[138.225276] Subtest invalid-null-pointer: SUCCESS (0.000s)
[138.322776] [012/137] (887s left) i915_pm_rpm (gem-evict-pwrite)
[139.797389] Starting subtest: gem-evict-pwrite
[140.371260] Subtest gem-evict-pwrite: SUCCESS (0.574s)
[140.565268] [013/137] (885s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[140.608424] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[140.609126] Starting dynamic subtest: smem
[140.700400] Dynamic subtest smem: SUCCESS (0.092s)
[140.701082] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (0.092s)
[140.871882] [014/137] (885s left) i915_hangman (engine-error-state-capture)
[140.934093] Starting subtest: engine-error-state-capture
[140.934782] Starting dynamic subtest: rcs0
[145.285385] Dynamic subtest rcs0: SUCCESS (4.351s)
[145.293536] Starting dynamic subtest: bcs0
[149.242413] Dynamic subtest bcs0: SUCCESS (3.957s)
[149.249780] Starting dynamic subtest: vcs0
[153.280755] Dynamic subtest vcs0: SUCCESS (4.038s)
[153.288666] Starting dynamic subtest: vecs0
[157.249736] Dynamic subtest vecs0: SUCCESS (3.969s)
[157.251222] Subtest engine-error-state-capture: SUCCESS (16.315s)
[157.322118] [015/137] (868s left) syncobj_wait (wait-for-submit-complex)
[157.375992] Starting subtest: wait-for-submit-complex
[157.437286] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[157.513516] [016/137] (868s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[157.618452] Starting subtest: yf-tiled-8bpp-rotate-0
[157.619819] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[157.699575] [017/137] (868s left) core_getstats
[157.816681] [018/137] (868s left) v3d/v3d_submit_csd (valid-multisync-submission)
[157.899203] Subtest valid-multisync-submission: SKIP (0.000s)
[157.949741] [019/137] (868s left) kms_plane_scaling (plane-upscale-with-modifiers-factor-0-25)
[158.050961] Starting subtest: plane-upscale-with-modifiers-factor-0-25
[158.051749] Starting dynamic subtest: pipe-A-HDMI-A-1
[158.636574] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.586s)
[158.640479] Starting dynamic subtest: pipe-B-HDMI-A-1
[159.237274] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.600s)
[159.238017] Subtest plane-upscale-with-modifiers-factor-0-25: SUCCESS (1.187s)
[159.373742] [020/137] (866s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[159.461774] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[159.463097] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[159.545322] [021/137] (866s left) kms_frontbuffer_tracking (basic)
[159.638072] Starting subtest: basic
[163.158762] Subtest basic: SUCCESS (3.522s)
[163.265505] [022/137] (862s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[163.363771] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[164.524230] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.161s)
[164.631978] [023/137] (861s left) gem_exec_params (no-bsd)
[164.686341] Starting subtest: no-bsd
[164.687126] Subtest no-bsd: SUCCESS (0.000s)
[164.784570] [024/137] (861s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[164.882519] Starting subtest: short-flip-before-cursor-toggle
[165.938160] Subtest short-flip-before-cursor-toggle: SUCCESS (1.056s)
[166.048524] [025/137] (859s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[166.191976] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[166.504267] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.311s)
[166.696400] [026/137] (859s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[166.781870] Starting subtest: addfb25-y-tiled-legacy
[166.782564] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[166.866905] [027/137] (859s left) api_intel_bb (reset-flags)
[166.906506] Starting subtest: reset-flags
[166.910402] Subtest reset-flags: SUCCESS (0.004s)
[167.023473] [028/137] (859s left) kms_chamelium_hpd (dp-hpd)
[167.170393] Subtest dp-hpd: SKIP (0.000s)
[167.221417] [029/137] (858s left) dmabuf_sync_file (import-multiple-read-write)
[167.291437] Starting subtest: import-multiple-read-write
[167.292891] Subtest import-multiple-read-write: SUCCESS (0.002s)
[167.338611] [030/137] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[167.425983] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[167.427319] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[167.510588] [031/137] (858s left) kms_cursor_edge_walk (64x64-top-edge)
[167.611566] Starting subtest: 64x64-top-edge
[167.612300] Starting dynamic subtest: pipe-A-HDMI-A-1
[171.309123] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.698s)
[171.313060] Starting dynamic subtest: pipe-B-HDMI-A-1
[174.928513] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.619s)
[174.929221] Subtest 64x64-top-edge: SUCCESS (7.318s)
[175.017161] [032/137] (851s left) kms_cursor_crc (cursor-sliding-64x64)
[175.103980] Starting subtest: cursor-sliding-64x64
[175.106365] Starting dynamic subtest: pipe-A-HDMI-A-1
[179.266457] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.160s)
[179.283793] Starting dynamic subtest: pipe-B-HDMI-A-1
[183.429390] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.150s)
[183.430096] Subtest cursor-sliding-64x64: SUCCESS (8.325s)
[183.552378] [033/137] (842s left) gem_exec_params (invalid-ring)
[183.593756] Starting subtest: invalid-ring
[183.594442] Subtest invalid-ring: SUCCESS (0.000s)
[183.686942] [034/137] (842s left) kms_vblank (pipe-c-query-forked-busy)
[183.780109] Subtest pipe-C-query-forked-busy: SKIP (0.000s)
[183.835412] [035/137] (842s left) gem_tiled_partial_pwrite_pread (reads)
[183.876956] Subtest reads: SKIP (0.000s)
[183.932488] [036/137] (842s left) kms_universal_plane (cursor-fb-leak-pipe-b)
[184.027100] Starting subtest: cursor-fb-leak-pipe-B
[184.654458] Subtest cursor-fb-leak-pipe-B: SUCCESS (0.627s)
[184.764434] [037/137] (841s left) kms_big_fb (linear-64bpp-rotate-0)
[184.854497] Starting subtest: linear-64bpp-rotate-0
[187.030804] Subtest linear-64bpp-rotate-0: SUCCESS (2.176s)
[187.193132] [038/137] (838s left) drm_read (empty-nonblock)
[187.334415] Starting subtest: empty-nonblock
[187.335113] Subtest empty-nonblock: SUCCESS (0.000s)
[187.460866] [039/137] (838s left) perf_pmu (busy-check-all)
[187.517870] Starting subtest: busy-check-all
[187.518542] Starting dynamic subtest: rcs0
[188.047258] Dynamic subtest rcs0: SUCCESS (0.529s)
[188.054478] Starting dynamic subtest: bcs0
[188.569263] Dynamic subtest bcs0: SUCCESS (0.521s)
[188.576432] Starting dynamic subtest: vcs0
[189.087264] Dynamic subtest vcs0: SUCCESS (0.517s)
[189.094583] Starting dynamic subtest: vecs0
[189.605341] Dynamic subtest vecs0: SUCCESS (0.517s)
[189.606536] Subtest busy-check-all: SUCCESS (2.087s)
[189.682041] [040/137] (836s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs)
[189.835821] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs
[189.837121] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[190.017743] [041/137] (836s left) gem_exec_reloc (basic-gtt-wc-active)
[190.059960] Subtest basic-gtt-wc-active: SKIP (0.000s)
[190.108740] [042/137] (836s left) kms_atomic (plane-immutable-zpos)
[190.231800] Starting subtest: plane-immutable-zpos
[190.557690] Subtest plane-immutable-zpos: SUCCESS (0.325s)
[190.702289] [043/137] (835s left) gem_mmap_offset (perf)
[190.741929] Starting subtest: perf
[190.742929] Starting dynamic subtest: smem0
[190.934274] Dynamic subtest smem0: SUCCESS (0.192s)
[190.934981] Subtest perf: SUCCESS (0.192s)
[191.011638] [044/137] (835s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[191.106743] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[191.108928] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.001s)
[191.203926] [045/137] (835s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[191.258728] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[191.361463] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[191.428945] [046/137] (834s left) syncobj_wait (invalid-signal-one-illegal-handle)
[191.483613] Starting subtest: invalid-signal-one-illegal-handle
[191.484331] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[191.545577] [047/137] (834s left) gem_exec_balancer (invalid-balancer)
[191.601987] Starting subtest: invalid-balancer
[192.354246] Subtest invalid-balancer: SUCCESS (0.752s)
[193.292317] [048/137] (833s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[193.510603] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[193.511284] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s)
[193.621725] [049/137] (832s left) gem_exec_whisper (basic-contexts-priority-all)
[193.666638] Starting subtest: basic-contexts-priority-all
[208.953858] Subtest basic-contexts-priority-all: SUCCESS (15.287s)
[209.127145] [050/137] (817s left) kms_atomic_transition (plane-toggle-modeset-transition)
[209.218671] Starting subtest: plane-toggle-modeset-transition
[209.219471] Starting dynamic subtest: pipe-A-HDMI-A-1
[210.483584] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.265s)
[210.492784] Starting dynamic subtest: pipe-B-HDMI-A-1
[211.481706] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.993s)
[211.486593] Subtest plane-toggle-modeset-transition: SUCCESS (2.269s)
[211.613093] [051/137] (814s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[211.654718] Starting subtest: single-wait-all-for-submit-signaled
[211.655402] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[211.707839] [052/137] (814s left) gem_workarounds (suspend-resume)
[211.754309] Starting subtest: suspend-resume
[228.600686] Subtest suspend-resume: SUCCESS (16.846s)
[231.713425] [053/137] (797s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[231.753730] Starting subtest: multi-wait-for-submit-submitted-signaled
[231.754401] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[231.820852] [054/137] (797s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf_tiled_ccs)
[232.050881] Subtest pipe-D-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[232.139288] [055/137] (797s left) gem_bad_reloc (negative-reloc)
[232.180494] Subtest negative-reloc: SKIP (0.000s)
[232.230120] [056/137] (797s left) gem_ctx_shared (disjoint-timelines)
[232.273432] Starting subtest: disjoint-timelines
[232.278266] Subtest disjoint-timelines: SUCCESS (0.005s)
[232.480841] [057/137] (796s left) kms_ccs (pipe-a-bad-pixel-format-yf_tiled_ccs)
[232.566281] Starting subtest: pipe-A-bad-pixel-format-yf_tiled_ccs
[232.567653] Subtest pipe-A-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[232.798200] [058/137] (796s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[232.882046] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[232.882763] Starting dynamic subtest: pipe-A-valid-mode
[233.733718] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.851s)
[233.734391] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (0.852s)
[233.861024] [059/137] (795s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[233.900563] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[233.901272] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[233.955363] [060/137] (795s left) syncobj_wait (wait-for-submit-snapshot)
[233.995194] Starting subtest: wait-for-submit-snapshot
[234.076782] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[234.148074] [061/137] (795s left) sysfs_preempt_timeout (timeout)
[234.200890] Starting subtest: timeout
[234.201591] Starting dynamic subtest: vecs0
[235.033663] Dynamic subtest vecs0: SUCCESS (0.832s)
[235.040318] Starting dynamic subtest: vcs0
[235.865652] Dynamic subtest vcs0: SUCCESS (0.831s)
[235.872259] Starting dynamic subtest: bcs0
[236.705704] Dynamic subtest bcs0: SUCCESS (0.839s)
[236.712968] Starting dynamic subtest: rcs0
[237.565505] Dynamic subtest rcs0: SUCCESS (0.859s)
[237.566758] Subtest timeout: SUCCESS (3.364s)
[237.641371] [062/137] (791s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[237.738593] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[238.117460] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.379s)
[238.270309] [063/137] (791s left) kms_sequence (get-idle)
[238.366348] Starting subtest: get-idle
[238.367081] Starting dynamic subtest: HDMI-A-1-pipe-A
[241.049655] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (2.683s)
[241.054316] Starting dynamic subtest: HDMI-A-1-pipe-B
[243.756630] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (2.706s)
[243.757323] Subtest get-idle: SUCCESS (5.391s)
[243.846705] [064/137] (785s left) gem_exec_schedule (u-fairslice-all)
[243.893607] Starting subtest: u-fairslice-all
[245.919402] Subtest u-fairslice-all: SUCCESS (2.026s)
[246.224418] [065/137] (783s left) api_intel_allocator (reopen-fork)
[246.271170] Starting subtest: reopen-fork
[249.505364] Subtest reopen-fork: SUCCESS (3.234s)
[249.561698] [066/137] (779s left) prime_self_import (basic-with_one_bo_two_files)
[249.611203] Starting subtest: basic-with_one_bo_two_files
[249.612868] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[249.693975] [067/137] (779s left) kms_cdclk (mode-transition-all-outputs)
[249.747053] Subtest mode-transition-all-outputs: SKIP (0.000s)
[249.761600] [068/137] (779s left) v3d/v3d_submit_cl (multisync-out-syncs)
[249.832566] Subtest multisync-out-syncs: SKIP (0.000s)
[249.887136] [069/137] (779s left) gem_mmap_gtt (cpuset-medium-copy)
[249.940196] Starting subtest: cpuset-medium-copy
[258.094838] Subtest cpuset-medium-copy: SUCCESS (8.155s)
[258.197956] [070/137] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[258.336852] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[258.338260] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[258.419839] [071/137] (771s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[258.518203] Starting subtest: multiplane-rotation-cropping-top
[279.810745] Subtest multiplane-rotation-cropping-top: SUCCESS (21.293s)
[279.898130] [072/137] (749s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[279.997393] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[279.998185] Starting dynamic subtest: pipe-A-valid-mode
[280.747082] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.750s)
[280.747782] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (0.752s)
[280.869778] [073/137] (748s left) gem_pipe_control_store_loop (reused-buffer)
[280.911224] Starting subtest: reused-buffer
[283.060617] Subtest reused-buffer: SUCCESS (2.149s)
[283.172767] [074/137] (746s left) kms_vblank (pipe-c-wait-busy-hang)
[283.263948] Subtest pipe-C-wait-busy-hang: SKIP (0.000s)
[283.316957] [075/137] (746s left) kms_vblank (pipe-c-wait-busy)
[283.402211] Subtest pipe-C-wait-busy: SKIP (0.000s)
[283.468437] [076/137] (746s left) kms_universal_plane (cursor-fb-leak-pipe-c)
[283.552641] Subtest cursor-fb-leak-pipe-C: SKIP (0.000s)
[283.620220] [077/137] (746s left) vgem_basic (setversion)
[283.666684] Starting subtest: setversion
[283.668037] Subtest setversion: SUCCESS (0.000s)
[283.722887] [078/137] (745s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[283.826541] Starting subtest: psr-rgb565-draw-pwrite
[283.827958] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[283.905103] [079/137] (745s left) kms_cursor_crc (cursor-onscreen-64x21)
[284.005321] Starting subtest: cursor-onscreen-64x21
[284.009041] Starting dynamic subtest: pipe-A-HDMI-A-1
[286.710940] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.702s)
[286.727584] Starting dynamic subtest: pipe-B-HDMI-A-1
[289.358094] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.635s)
[289.358787] Subtest cursor-onscreen-64x21: SUCCESS (5.354s)
[289.478179] [080/137] (740s left) gem_watchdog (default-virtual)
[289.523041] Starting subtest: default-virtual
[293.782228] Subtest default-virtual: SUCCESS (4.262s)
[293.837754] [081/137] (735s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[293.928813] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[293.930154] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[294.013900] [082/137] (735s left) kms_cursor_crc (cursor-offscreen-32x32)
[294.104525] Starting subtest: cursor-offscreen-32x32
[294.127505] Subtest cursor-offscreen-32x32: SKIP (0.021s)
[294.220773] [083/137] (735s left) gem_exec_fence (syncobj-unused-fence)
[294.528629] Starting subtest: syncobj-unused-fence
[294.530305] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[294.834956] [084/137] (734s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[295.043733] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[295.045102] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[295.169057] [085/137] (734s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-25)
[295.253101] Starting subtest: plane-downscale-with-rotation-factor-0-25
[295.253826] Starting dynamic subtest: pipe-A-HDMI-A-1
[295.262504] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.008s)
[295.267675] Starting dynamic subtest: pipe-B-HDMI-A-1
[295.278862] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.016s)
[295.280238] Subtest plane-downscale-with-rotation-factor-0-25: SKIP (0.025s)
[295.377579] [086/137] (734s left) vc4/vc4_perfmon (create-single-perfmon)
[295.441924] Subtest create-single-perfmon: SKIP (0.000s)
[295.491087] [087/137] (734s left) gem_exec_flush (basic-wb-ro-default)
[295.534090] Starting subtest: basic-wb-ro-default
[300.941776] Subtest basic-wb-ro-default: SUCCESS (5.408s)
[301.141182] [088/137] (728s left) i915_query (query-topology-garbage-items)
[301.203046] Starting subtest: query-topology-garbage-items
[301.203746] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[301.265473] [089/137] (728s left) gem_exec_schedule (preemptive-hang)
[301.434281] Starting subtest: preemptive-hang
[301.434990] Starting dynamic subtest: rcs0
[307.909431] Dynamic subtest rcs0: SUCCESS (6.473s)
[307.915414] Starting dynamic subtest: bcs0
[313.853071] Dynamic subtest bcs0: SUCCESS (5.944s)
[313.860424] Starting dynamic subtest: vcs0
[319.877373] Dynamic subtest vcs0: SUCCESS (6.021s)
[319.883335] Starting dynamic subtest: vecs0
[325.893280] Dynamic subtest vecs0: SUCCESS (6.015s)
[325.894461] Subtest preemptive-hang: SUCCESS (24.457s)
[326.060274] [090/137] (703s left) gem_userptr_blits (process-exit-busy)
[326.119618] Starting subtest: process-exit-busy
[326.129062] Subtest process-exit-busy: SUCCESS (0.009s)
[326.231243] [091/137] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[326.331585] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[329.024608] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.695s)
[329.150927] [092/137] (700s left) kms_plane_cursor (primary)
[329.236040] Starting subtest: primary
[329.237387] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[331.967516] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.730s)
[332.032139] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[334.755740] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.731s)
[334.819700] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[337.545193] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.731s)
[337.635408] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[340.387386] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.756s)
[340.430290] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[343.157687] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.732s)
[343.201121] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[345.927676] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.732s)
[345.994617] Subtest primary: SUCCESS (16.758s)
[346.086595] [093/137] (683s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs)
[346.315245] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[346.404985] [094/137] (683s left) syncobj_basic (bad-pad-handle-to-fd)
[346.445663] Starting subtest: bad-pad-handle-to-fd
[346.446344] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[346.499709] [095/137] (683s left) gem_exec_fence (syncobj-timeline-repeat)
[346.922521] Starting subtest: syncobj-timeline-repeat
[347.125423] Subtest syncobj-timeline-repeat: SUCCESS (0.206s)
[347.309069] [096/137] (682s left) v3d/v3d_perfmon (get-values-invalid-perfmon)
[347.380194] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[347.436113] [097/137] (682s left) gem_render_copy (linear-to-vebox-yf-tiled)
[347.490580] Starting subtest: linear-to-vebox-yf-tiled
[347.491259] Starting dynamic subtest: smem
[347.557955] Dynamic subtest smem: SUCCESS (0.067s)
[347.558622] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.067s)
[347.738351] [098/137] (682s left) gem_pwrite (basic-random)
[347.793925] Subtest basic-random: SKIP (0.000s)
[347.844952] [099/137] (682s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[347.969863] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[347.971225] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[348.036532] [100/137] (681s left) perf_pmu (most-busy-idle-check-all)
[348.094842] Starting subtest: most-busy-idle-check-all
[348.095529] Starting dynamic subtest: rcs0
[348.712267] Dynamic subtest rcs0: SUCCESS (0.615s)
[348.720521] Starting dynamic subtest: bcs0
[349.324345] Dynamic subtest bcs0: SUCCESS (0.613s)
[349.332360] Starting dynamic subtest: vcs0
[349.949354] Dynamic subtest vcs0: SUCCESS (0.624s)
[349.957319] Starting dynamic subtest: vecs0
[350.566272] Dynamic subtest vecs0: SUCCESS (0.616s)
[350.567526] Subtest most-busy-idle-check-all: SUCCESS (2.471s)
[350.644207] [101/137] (679s left) gem_exec_balancer (bonded-false-hang)
[351.561718] Starting subtest: bonded-false-hang
[352.303142] Subtest bonded-false-hang: SUCCESS (0.741s)
[352.369645] [102/137] (677s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[352.461769] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[352.463133] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[352.558284] [103/137] (677s left) prime_udl
[352.649810] [104/137] (677s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[352.742036] Starting subtest: fbc-rgb565-draw-mmap-wc
[355.519171] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (2.779s)
[355.645219] [105/137] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[355.732119] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[355.733429] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[355.817250] [106/137] (674s left) syncobj_wait (invalid-wait-bad-flags)
[355.868259] Starting subtest: invalid-wait-bad-flags
[355.868963] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[355.937749] [107/137] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[356.032815] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[356.034144] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[356.123204] [108/137] (673s left) vc4/vc4_wait_bo (unused-bo-1ns)
[356.203034] Subtest unused-bo-1ns: SKIP (0.000s)
[356.255909] [109/137] (673s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[356.355949] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[356.357298] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[356.445690] [110/137] (673s left) gem_exec_fair (basic-pace)
[356.499585] Starting subtest: basic-pace
[356.500271] Starting dynamic subtest: rcs0
[362.027504] Dynamic subtest rcs0: SUCCESS (5.529s)
[362.032766] Starting dynamic subtest: bcs0
[366.436212] Dynamic subtest bcs0: FAIL (4.392s)
[366.448933] Starting dynamic subtest: vcs0
[370.833232] Dynamic subtest vcs0: FAIL (4.395s)
[370.843838] Starting dynamic subtest: vecs0
[375.225886] Dynamic subtest vecs0: FAIL (4.387s)
[375.227117] Subtest basic-pace: FAIL (18.705s)
[375.381773] [111/137] (654s left) sw_sync (sync_busy_fork_unixsocket)
[375.432715] Starting subtest: sync_busy_fork_unixsocket
[375.438785] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[375.499093] [112/137] (654s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[375.597686] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[375.599030] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[375.683606] [113/137] (654s left) gem_lmem_swapping (random)
[375.738820] Subtest random: SKIP (0.000s)
[375.778498] [114/137] (654s left) kms_flip (2x-flip-vs-panning)
[375.866758] Starting subtest: 2x-flip-vs-panning
[375.868199] Subtest 2x-flip-vs-panning: SKIP (0.001s)
[375.947622] [115/137] (654s left) kms_chamelium_edid (dp-mode-timings)
[376.078519] Subtest dp-mode-timings: SKIP (0.000s)
[376.132814] [116/137] (654s left) gem_exec_params (cliprects_ptr-dirt)
[376.173611] Starting subtest: cliprects_ptr-dirt
[376.174335] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[376.269240] [117/137] (653s left) kms_vblank (pipe-c-query-forked-hang)
[376.355369] Subtest pipe-C-query-forked-hang: SKIP (0.000s)
[376.419980] [118/137] (653s left) i915_pm_rpm (modeset-non-lpsp-stress)
[377.839257] Starting subtest: modeset-non-lpsp-stress
[378.124505] Subtest modeset-non-lpsp-stress: SKIP (0.285s)
[378.326381] [119/137] (651s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[378.412863] Starting subtest: short-flip-before-cursor-atomic-transitions
[379.466970] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.055s)
[379.583639] [120/137] (650s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[379.672064] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[379.673399] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[379.781112] [121/137] (650s left) kms_lease (invalid-create-leases)
[379.876448] Starting subtest: invalid-create-leases
[379.879267] Subtest invalid-create-leases: SUCCESS (0.003s)
[379.943050] [122/137] (650s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[380.075387] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[380.130622] [123/137] (650s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs)
[380.361833] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[380.450237] [124/137] (649s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-0-25)
[380.534144] Starting subtest: planes-downscale-factor-0-75-upscale-0-25
[380.534837] Starting dynamic subtest: pipe-A-HDMI-A-1
[380.628742] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.094s)
[380.633933] Starting dynamic subtest: pipe-B-HDMI-A-1
[380.754333] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.125s)
[380.755117] Subtest planes-downscale-factor-0-75-upscale-0-25: SUCCESS (0.221s)
[380.874585] [125/137] (649s left) syncobj_wait (wait-all-for-submit-snapshot)
[380.914353] Starting subtest: wait-all-for-submit-snapshot
[380.995135] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[381.064096] [126/137] (649s left) gem_exec_suspend (basic-s3-devices)
[381.107205] Starting subtest: basic-S3-devices
[381.107921] Starting dynamic subtest: smem
[388.518496] Dynamic subtest smem: SUCCESS (7.411s)
[388.519226] Subtest basic-S3-devices: SUCCESS (7.411s)
[390.701295] [127/137] (641s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[390.937024] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[391.028401] [128/137] (641s left) i915_pm_dc (dc3co-vpb-simulation)
[392.125807] Starting subtest: dc3co-vpb-simulation
[392.127433] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[392.263689] [129/137] (640s left) gem_spin_batch (user-each)
[392.309534] Starting subtest: user-each
[395.637810] Subtest user-each: SUCCESS (3.328s)
[395.811040] [130/137] (636s left) gem_ctx_persistence (idempotent)
[395.865087] Starting subtest: idempotent
[395.865764] Subtest idempotent: SUCCESS (0.000s)
[395.927287] [131/137] (636s left) gem_exec_flush (basic-batch-kernel-default-uc)
[395.982900] Starting subtest: basic-batch-kernel-default-uc
[401.570874] Subtest basic-batch-kernel-default-uc: SUCCESS (5.588s)
[401.766530] [132/137] (630s left) kms_psr (psr2_cursor_render)
[401.831644] Subtest psr2_cursor_render: SKIP (0.000s)
[401.856420] [133/137] (630s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[401.957635] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[401.959027] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[402.058305] [134/137] (630s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[402.160503] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[402.161870] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[402.267652] [135/137] (630s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[402.357387] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[402.359967] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.001s)
[402.456717] [136/137] (630s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_ccs)
[402.644495] Starting subtest: pipe-B-bad-pixel-format-y_tiled_ccs
[402.645858] Subtest pipe-B-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[402.785067] [137/137] (629s left) gem_create (create-ext-placement-each)
[402.930055] Starting subtest: create-ext-placement-each
[402.930845] Subtest create-ext-placement-each: SUCCESS (0.000s)
[403.014529] Closing watchdogs
Done.