[44.925298] Initializing watchdogs
[44.925355]   /dev/watchdog0
[44.931500] [001/144] (960s left) kms_psr (pr-cursor-mmap-cpu)
[46.898719] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[46.922606] [002/144] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[48.875932] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[48.877584] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[48.950450] [003/144] (956s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[50.986349] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[50.988013] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[51.069363] [004/144] (954s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[53.095795] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[53.097483] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[53.165593] [005/144] (952s left) gem_exec_fence (syncobj-export)
[54.046197] Starting subtest: syncobj-export
[54.077861] Subtest syncobj-export: SUCCESS (0.032s)
[54.461336] [006/144] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[56.422122] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[59.118903] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.698s)
[59.234878] [007/144] (946s left) kms_hdmi_inject (inject-4k)
[59.340304] Starting subtest: inject-4k
[59.476155] Subtest inject-4k: SUCCESS (0.135s)
[61.527404] [008/144] (944s left) kms_psr (psr-no-drrs)
[63.514586] Subtest psr-no-drrs: SKIP (0.000s)
[63.536904] [009/144] (942s left) kms_ccs (pipe-b-bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[65.537533] Starting subtest: pipe-B-bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[65.539289] Subtest pipe-B-bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[65.677643] [010/144] (939s left) vc4/vc4_tiling (set-bad-modifier)
[65.749962] Subtest set-bad-modifier: SKIP (0.000s)
[65.795045] [011/144] (939s left) kms_color (ctm-negative)
[67.755025] Starting subtest: ctm-negative
[67.755897] Starting dynamic subtest: pipe-A
[68.372872] Dynamic subtest pipe-A: SUCCESS (0.618s)
[68.379062] Starting dynamic subtest: pipe-B
[68.806338] Dynamic subtest pipe-B: SUCCESS (0.434s)
[68.811288] Starting dynamic subtest: pipe-C
[69.277881] Dynamic subtest pipe-C: SUCCESS (0.470s)
[69.283436] Starting dynamic subtest: pipe-D
[69.738120] Dynamic subtest pipe-D: SUCCESS (0.460s)
[69.738915] Subtest ctm-negative: SUCCESS (1.983s)
[69.877639] [012/144] (935s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[71.890958] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[71.892808] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[72.025392] [013/144] (933s left) kms_addfb_basic (too-wide)
[73.969025] Starting subtest: too-wide
[73.970057] Subtest too-wide: SUCCESS (0.000s)
[74.047010] [014/144] (931s left) kms_flip (nonexisting-fb)
[76.061874] Starting subtest: nonexisting-fb
[76.067771] Starting dynamic subtest: A-HDMI-A3
[76.356902] Dynamic subtest A-HDMI-A3: SUCCESS (0.289s)
[76.364791] Starting dynamic subtest: B-HDMI-A3
[76.534067] Dynamic subtest B-HDMI-A3: SUCCESS (0.177s)
[76.539714] Starting dynamic subtest: C-HDMI-A3
[76.694228] Dynamic subtest C-HDMI-A3: SUCCESS (0.160s)
[76.700286] Starting dynamic subtest: D-HDMI-A3
[76.854225] Dynamic subtest D-HDMI-A3: SUCCESS (0.160s)
[76.855187] Subtest nonexisting-fb: SUCCESS (0.793s)
[77.007533] [015/144] (928s left) kms_frontbuffer_tracking (fbc-tiling-y)
[78.971692] Starting subtest: fbc-tiling-y
[78.973416] Subtest fbc-tiling-y: SKIP (0.000s)
[79.043192] [016/144] (926s left) kms_pm_backlight (bad-brightness)
[81.085449] Subtest bad-brightness: SKIP (0.000s)
[81.099287] [017/144] (924s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-rc-ccs)
[83.102955] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs
[83.104946] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[83.263658] [018/144] (922s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[85.223403] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[85.239174] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.015s)
[85.299106] [019/144] (920s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[87.317380] Starting subtest: read-crc-frame-sequence
[87.318390] Starting dynamic subtest: pipe-A-HDMI-A-3
[87.909549] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.592s)
[87.918031] Starting dynamic subtest: pipe-B-HDMI-A-3
[88.363455] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.452s)
[88.368407] Starting dynamic subtest: pipe-C-HDMI-A-3
[88.801427] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.437s)
[88.806432] Starting dynamic subtest: pipe-D-HDMI-A-3
[89.293646] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.492s)
[89.294579] Subtest read-crc-frame-sequence: SUCCESS (1.977s)
[89.433739] [020/144] (916s left) fbdev (info)
[89.480036] Starting subtest: info
[89.481185] Subtest info: SUCCESS (0.000s)
[89.536675] [021/144] (916s left) gem_exec_capture (capture)
[89.595562] Starting subtest: capture
[89.596478] Starting dynamic subtest: rcs0-smem
[90.541896] Dynamic subtest rcs0-smem: SUCCESS (0.946s)
[90.547231] Starting dynamic subtest: rcs0-lmem0
[91.468904] Dynamic subtest rcs0-lmem0: SUCCESS (0.927s)
[91.473991] Starting dynamic subtest: bcs0-smem
[92.375840] Dynamic subtest bcs0-smem: SUCCESS (0.907s)
[92.380846] Starting dynamic subtest: bcs0-lmem0
[93.276659] Dynamic subtest bcs0-lmem0: SUCCESS (0.901s)
[93.281626] Starting dynamic subtest: vcs0-smem
[94.679948] Dynamic subtest vcs0-smem: SUCCESS (1.402s)
[94.684913] Starting dynamic subtest: vcs0-lmem0
[95.771155] Dynamic subtest vcs0-lmem0: SUCCESS (1.091s)
[95.775982] Starting dynamic subtest: vcs1-smem
[96.670990] Dynamic subtest vcs1-smem: SUCCESS (0.900s)
[96.676156] Starting dynamic subtest: vcs1-lmem0
[97.748841] Dynamic subtest vcs1-lmem0: SUCCESS (1.078s)
[97.753724] Starting dynamic subtest: vecs0-smem
[98.646665] Dynamic subtest vecs0-smem: SUCCESS (0.898s)
[98.651807] Starting dynamic subtest: vecs0-lmem0
[99.732858] Dynamic subtest vecs0-lmem0: SUCCESS (1.086s)
[99.737760] Starting dynamic subtest: vecs1-smem
[100.625908] Dynamic subtest vecs1-smem: SUCCESS (0.892s)
[100.630855] Starting dynamic subtest: vecs1-lmem0
[101.718217] Dynamic subtest vecs1-lmem0: SUCCESS (1.092s)
[101.723077] Starting dynamic subtest: ccs0-smem
[102.615874] Dynamic subtest ccs0-smem: SUCCESS (0.898s)
[102.620831] Starting dynamic subtest: ccs0-lmem0
[103.515777] Dynamic subtest ccs0-lmem0: SUCCESS (0.900s)
[103.520624] Starting dynamic subtest: ccs1-smem
[104.414770] Dynamic subtest ccs1-smem: SUCCESS (0.900s)
[104.419886] Starting dynamic subtest: ccs1-lmem0
[105.314031] Dynamic subtest ccs1-lmem0: SUCCESS (0.899s)
[105.319006] Starting dynamic subtest: ccs2-smem
[106.716698] Dynamic subtest ccs2-smem: SUCCESS (1.403s)
[106.721814] Starting dynamic subtest: ccs2-lmem0
[107.623163] Dynamic subtest ccs2-lmem0: SUCCESS (0.906s)
[107.627993] Starting dynamic subtest: ccs3-smem
[108.523720] Dynamic subtest ccs3-smem: SUCCESS (0.901s)
[108.528710] Starting dynamic subtest: ccs3-lmem0
[109.431910] Dynamic subtest ccs3-lmem0: SUCCESS (0.908s)
[109.432743] Subtest capture: SUCCESS (19.836s)
[109.533882] [022/144] (896s left) kms_cursor_crc (cursor-sliding-256x256)
[111.645232] Starting subtest: cursor-sliding-256x256
[111.648979] Starting dynamic subtest: pipe-A-HDMI-A-3
[115.960657] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.311s)
[115.987751] Starting dynamic subtest: pipe-D-HDMI-A-3
[120.223330] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.239s)
[120.224248] Subtest cursor-sliding-256x256: SUCCESS (8.578s)
[120.448210] [023/144] (885s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[122.416789] Starting subtest: fbcpsr-slowdraw
[122.418665] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[122.495750] [024/144] (883s left) gem_pread (exhaustion)
[122.622572] Subtest exhaustion: SKIP (0.000s)
[122.655359] [025/144] (883s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[124.694410] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-gen12-rc-ccs
[124.696221] Subtest pipe-A-missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[124.844436] [026/144] (880s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[126.824007] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[126.825616] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[126.899260] [027/144] (878s left) perf_pmu (rc6-suspend)
[127.021804] Starting subtest: rc6-suspend
[151.994541] Subtest rc6-suspend: SUCCESS (9.848s)
[153.545581] [028/144] (868s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[153.611073] Starting subtest: invalid-multi-wait-all-unsubmitted
[153.612000] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[153.711396] [029/144] (868s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[155.686051] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[155.687775] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[155.761183] [030/144] (866s left) kms_ccs (pipe-c-missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[157.886598] Starting subtest: pipe-C-missing-ccs-buffer-y-tiled-gen12-mc-ccs
[157.888492] Subtest pipe-C-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[158.006249] [031/144] (864s left) gem_exec_reloc (basic-concurrent0)
[158.066918] Subtest basic-concurrent0: SKIP (0.000s)
[158.101263] [032/144] (863s left) kms_dsc (dsc-with-bpc-formats)
[160.074053] Starting subtest: dsc-with-bpc-formats
[160.075955] Subtest dsc-with-bpc-formats: SKIP (0.002s)
[160.141389] [033/144] (861s left) gen9_exec_parse (basic-rejected)
[160.282221] Subtest basic-rejected: SKIP (0.000s)
[160.324074] [034/144] (861s left) gem_eio (in-flight-external)
[160.630071] Starting subtest: in-flight-external
[161.487325] Subtest in-flight-external: SUCCESS (0.858s)
[163.442010] [035/144] (858s left) kms_pm_rpm (dpms-lpsp)
[167.617233] Starting subtest: dpms-lpsp
[167.619757] Subtest dpms-lpsp: SKIP (0.000s)
[168.762573] [036/144] (853s left) gem_lmem_swapping (massive-random)
[178.487009] Starting subtest: massive-random
[178.487857] Starting dynamic subtest: lmem0
[178.692717] Dynamic subtest lmem0: SUCCESS (0.200s)
[178.693930] Subtest massive-random: SUCCESS (0.200s)
[180.690544] [037/144] (841s left) gem_watchdog (default-virtual)
[189.637122] Starting subtest: default-virtual
[199.728483] Subtest default-virtual: SUCCESS (10.092s)
[199.802299] [038/144] (822s left) gem_workarounds (suspend-resume-context)
[199.864930] Starting subtest: suspend-resume-context
[218.828546] Subtest suspend-resume-context: SUCCESS (3.528s)
[222.952935] [039/144] (818s left) gem_exec_balancer (bonded-false-hang)
[223.276635] Starting subtest: bonded-false-hang
[223.278568] Subtest bonded-false-hang: SKIP (0.000s)
[223.364698] [040/144] (818s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[223.416573] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[223.417488] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[223.533190] [041/144] (818s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[225.547501] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[225.549117] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[225.616906] [042/144] (816s left) gem_exec_balancer (hang)
[225.982580] Starting subtest: hang
[232.279613] Subtest hang: SUCCESS (6.297s)
[232.370826] [043/144] (809s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[234.329630] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[234.331265] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[234.402974] [044/144] (807s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[236.504103] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[236.505958] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[236.636344] [045/144] (805s left) gem_mmap_gtt (basic-write-read-distinct)
[236.708265] Subtest basic-write-read-distinct: SKIP (0.000s)
[236.745880] [046/144] (805s left) i915_suspend (debugfs-reader)
[236.810337] Starting subtest: debugfs-reader
[257.835170] Subtest debugfs-reader: SUCCESS (5.589s)
[259.895241] [047/144] (799s left) gem_huc_copy (huc-copy)
[259.980013] Starting subtest: huc-copy
[259.984632] Subtest huc-copy: SUCCESS (0.005s)
[260.085691] [048/144] (799s left) gem_exec_schedule (implicit-read-write)
[260.150277] Starting subtest: implicit-read-write
[260.151198] Starting dynamic subtest: rcs0
[260.432987] Dynamic subtest rcs0: SUCCESS (0.282s)
[260.440727] Starting dynamic subtest: bcs0
[260.631153] Dynamic subtest bcs0: SUCCESS (0.198s)
[260.638967] Starting dynamic subtest: vcs0
[260.841595] Dynamic subtest vcs0: SUCCESS (0.210s)
[260.849602] Starting dynamic subtest: vcs1
[261.055489] Dynamic subtest vcs1: SUCCESS (0.213s)
[261.063367] Starting dynamic subtest: vecs0
[261.271902] Dynamic subtest vecs0: SUCCESS (0.216s)
[261.279888] Starting dynamic subtest: vecs1
[261.528018] Dynamic subtest vecs1: SUCCESS (0.256s)
[261.538438] Starting dynamic subtest: ccs0
[261.750673] Dynamic subtest ccs0: SUCCESS (0.222s)
[261.758584] Starting dynamic subtest: ccs1
[261.953736] Dynamic subtest ccs1: SUCCESS (0.203s)
[261.961521] Starting dynamic subtest: ccs2
[262.159589] Dynamic subtest ccs2: SUCCESS (0.206s)
[262.167519] Starting dynamic subtest: ccs3
[262.364806] Dynamic subtest ccs3: SUCCESS (0.205s)
[262.365774] Subtest implicit-read-write: SUCCESS (2.214s)
[262.765507] [049/144] (796s left) kms_cursor_crc (cursor-offscreen-64x21)
[264.833401] Starting subtest: cursor-offscreen-64x21
[264.837170] Starting dynamic subtest: pipe-A-HDMI-A-3
[267.328607] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.490s)
[267.358515] Starting dynamic subtest: pipe-D-HDMI-A-3
[269.657732] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.306s)
[269.658609] Subtest cursor-offscreen-64x21: SUCCESS (4.824s)
[269.942012] [050/144] (789s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[271.902819] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[271.904632] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[271.977098] [051/144] (787s left) kms_selftest (drm_damage_helper)
[272.095061] Starting subtest: drm_damage_helper
[272.240632] Starting dynamic subtest: drm_test_damage_iter_no_damage
[272.257304] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.017s)
[272.285214] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[272.286398] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.000s)
[272.299596] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[272.300539] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.000s)
[272.312805] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[272.313754] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.000s)
[272.323576] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[272.324627] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.000s)
[272.332673] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[272.333517] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.000s)
[272.341201] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[272.342043] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.000s)
[272.349724] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[272.350519] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.000s)
[272.358192] Starting dynamic subtest: drm_test_damage_iter_single_damage
[272.359103] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.000s)
[272.368921] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[272.369736] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.000s)
[272.377368] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[272.378182] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.000s)
[272.386286] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[272.387458] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.000s)
[272.395367] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[272.396464] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.000s)
[272.404475] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[272.405525] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.000s)
[272.413245] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[272.414144] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.000s)
[272.422445] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[272.423523] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.000s)
[272.431633] Starting dynamic subtest: drm_test_damage_iter_damage
[272.432935] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.000s)
[272.441632] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[272.442464] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.000s)
[272.450480] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[272.451519] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.000s)
[272.459452] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[272.460507] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.000s)
[272.468337] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[272.469173] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.000s)
[272.469962] Subtest drm_damage_helper: SUCCESS (0.190s)
[272.483528] [052/144] (786s left) syncobj_wait (reset-during-wait-for-submit)
[272.546075] Starting subtest: reset-during-wait-for-submit
[272.649764] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[272.713780] [053/144] (786s left) kms_busy (extended-modeset-hang-newfb)
[274.678721] Starting subtest: extended-modeset-hang-newfb
[274.679653] Starting dynamic subtest: pipe-A
[290.229240] Dynamic subtest pipe-A: SUCCESS (15.549s)
[290.239689] Starting dynamic subtest: pipe-D
[305.721045] Dynamic subtest pipe-D: SUCCESS (15.488s)
[305.721953] Subtest extended-modeset-hang-newfb: SUCCESS (31.043s)
[305.875739] [054/144] (753s left) kms_psr (psr2-cursor-render)
[307.859241] Subtest psr2-cursor-render: SKIP (0.000s)
[307.879386] [055/144] (751s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[309.830845] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[309.831720] Starting dynamic subtest: pipe-A-valid-mode
[313.253911] Dynamic subtest pipe-A-valid-mode: SUCCESS (3.423s)
[313.254812] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (3.424s)
[313.374360] [056/144] (746s left) perf_pmu (busy-no-semaphores)
[313.432652] Starting subtest: busy-no-semaphores
[313.433484] Starting dynamic subtest: rcs0
[314.001571] Dynamic subtest rcs0: SUCCESS (0.568s)
[314.013520] Starting dynamic subtest: bcs0
[314.551365] Dynamic subtest bcs0: SUCCESS (0.548s)
[314.562572] Starting dynamic subtest: vcs0
[315.099922] Dynamic subtest vcs0: SUCCESS (0.547s)
[315.111687] Starting dynamic subtest: vcs1
[315.649139] Dynamic subtest vcs1: SUCCESS (0.547s)
[315.660745] Starting dynamic subtest: vecs0
[316.198129] Dynamic subtest vecs0: SUCCESS (0.547s)
[316.209813] Starting dynamic subtest: vecs1
[316.749964] Dynamic subtest vecs1: SUCCESS (0.550s)
[316.762955] Starting dynamic subtest: ccs0
[317.299230] Dynamic subtest ccs0: SUCCESS (0.547s)
[317.311673] Starting dynamic subtest: ccs1
[317.848381] Dynamic subtest ccs1: SUCCESS (0.547s)
[317.858338] Starting dynamic subtest: ccs2
[318.397813] Dynamic subtest ccs2: SUCCESS (0.548s)
[318.410580] Starting dynamic subtest: ccs3
[318.948164] Dynamic subtest ccs3: SUCCESS (0.548s)
[318.949983] Subtest busy-no-semaphores: SUCCESS (5.515s)
[319.056550] [057/144] (740s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[319.111494] Starting subtest: wait-all-for-submit-delayed-submit
[319.214247] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.101s)
[319.319719] [058/144] (740s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[321.289305] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[323.723694] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.434s)
[323.860145] [059/144] (735s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[325.847575] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[325.902682] [060/144] (733s left) kms_flip (2x-plain-flip-ts-check)
[327.865984] Starting subtest: 2x-plain-flip-ts-check
[327.880101] Subtest 2x-plain-flip-ts-check: SKIP (0.015s)
[327.941462] [061/144] (731s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[329.935010] Starting subtest: y-tiled-64bpp-rotate-180
[329.936823] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[330.010248] [062/144] (729s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[332.038355] Starting subtest: x-tiled-16bpp-rotate-180
[333.708617] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.670s)
[333.827699] [063/144] (725s left) syncobj_timeline (invalid-signal-illegal-handle)
[333.882455] Starting subtest: invalid-signal-illegal-handle
[333.883482] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[333.990221] [064/144] (725s left) kms_frontbuffer_tracking (fbc-2p-rte)
[335.976287] Starting subtest: fbc-2p-rte
[335.978311] Subtest fbc-2p-rte: SKIP (0.000s)
[336.061923] [065/144] (723s left) vgem_basic (dmabuf-fence-before)
[336.175276] Starting subtest: dmabuf-fence-before
[336.176401] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[336.235349] [066/144] (723s left) core_auth (getclient-simple)
[336.312798] Starting subtest: getclient-simple
[336.324714] Subtest getclient-simple: SUCCESS (0.012s)
[336.398432] [067/144] (723s left) syncobj_timeline (invalid-query-zero-handles)
[336.473492] Starting subtest: invalid-query-zero-handles
[336.474475] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[336.546552] [068/144] (723s left) gem_madvise (dontneed-after-mmap)
[336.611066] Starting subtest: dontneed-after-mmap
[336.622652] Subtest dontneed-after-mmap: SUCCESS (0.012s)
[336.741719] [069/144] (723s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[338.719467] Starting subtest: cursorA-vs-flipB-varying-size
[338.722476] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[338.774909] [070/144] (721s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[340.760929] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[340.762745] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[340.846979] [071/144] (718s left) kms_chamelium_frames (hdmi-frame-dump)
[342.915401] Subtest hdmi-frame-dump: SKIP (0.000s)
[342.971971] [072/144] (716s left) kms_psr (fbc-psr2-primary-blt)
[344.940875] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[344.969118] [073/144] (714s left) gem_userptr_blits (unsync-unmap-cycles)
[345.035485] Subtest unsync-unmap-cycles: SKIP (0.000s)
[345.167992] [074/144] (714s left) gem_fence_thrash (bo-write-verify-none)
[345.249339] Starting subtest: bo-write-verify-none
[345.269631] Subtest bo-write-verify-none: SKIP (0.019s)
[345.304387] [075/144] (714s left) gem_userptr_blits (sync-overlap)
[345.388867] Starting subtest: sync-overlap
[345.389703] Subtest sync-overlap: SUCCESS (0.000s)
[345.523963] [076/144] (714s left) i915_pciid
[345.688684] [077/144] (714s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[345.786361] Starting subtest: invalid-single-wait-all-unsubmitted
[345.787345] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[345.886799] [078/144] (714s left) v3d/v3d_submit_csd (job-perfmon)
[345.993308] Subtest job-perfmon: SKIP (0.000s)
[346.043294] [079/144] (713s left) kms_flip (plain-flip-ts-check-interruptible)
[348.007147] Starting subtest: plain-flip-ts-check-interruptible
[348.014103] Starting dynamic subtest: A-HDMI-A3
[356.020966] Dynamic subtest A-HDMI-A3: SUCCESS (8.007s)
[356.030852] Starting dynamic subtest: B-HDMI-A3
[363.952282] Dynamic subtest B-HDMI-A3: SUCCESS (7.930s)
[363.961474] Starting dynamic subtest: C-HDMI-A3
[371.881308] Dynamic subtest C-HDMI-A3: SUCCESS (7.928s)
[371.890308] Starting dynamic subtest: D-HDMI-A3
[379.809501] Dynamic subtest D-HDMI-A3: SUCCESS (7.927s)
[379.810373] Subtest plain-flip-ts-check-interruptible: SUCCESS (31.802s)
[379.953621] [080/144] (680s left) gem_ctx_shared (exec-single-timeline)
[380.020509] Starting subtest: exec-single-timeline
[380.021521] Starting dynamic subtest: rcs0
[381.118725] Dynamic subtest rcs0: SUCCESS (1.095s)
[381.128266] Starting dynamic subtest: bcs0
[382.143050] Dynamic subtest bcs0: SUCCESS (1.021s)
[382.152475] Starting dynamic subtest: vcs0
[383.165966] Dynamic subtest vcs0: SUCCESS (1.022s)
[383.176195] Starting dynamic subtest: vcs1
[384.189495] Dynamic subtest vcs1: SUCCESS (1.022s)
[384.201453] Starting dynamic subtest: vecs0
[385.216701] Dynamic subtest vecs0: SUCCESS (1.021s)
[385.225474] Starting dynamic subtest: vecs1
[386.237376] Dynamic subtest vecs1: SUCCESS (1.021s)
[386.248400] Starting dynamic subtest: ccs0
[387.261779] Dynamic subtest ccs0: SUCCESS (1.022s)
[387.271928] Starting dynamic subtest: ccs1
[388.285778] Dynamic subtest ccs1: SUCCESS (1.022s)
[388.296188] Starting dynamic subtest: ccs2
[389.309882] Dynamic subtest ccs2: SUCCESS (1.021s)
[389.320128] Starting dynamic subtest: ccs3
[390.333975] Dynamic subtest ccs3: SUCCESS (1.021s)
[390.335884] Subtest exec-single-timeline: SUCCESS (10.313s)
[390.575056] [081/144] (669s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[392.601171] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-gen12-rc-ccs
[392.602813] Subtest pipe-B-missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[392.736374] [082/144] (667s left) v3d/v3d_mmap (mmap-bo)
[392.803900] Subtest mmap-bo: SKIP (0.000s)
[392.854346] [083/144] (667s left) gem_softpin (evict-active-interruptible)
[392.932557] Starting subtest: evict-active-interruptible
[392.949186] Subtest evict-active-interruptible: SUCCESS (0.017s)
[393.022853] [084/144] (667s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[394.987285] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[395.603392] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.616s)
[395.774115] [085/144] (664s left) gem_exec_params (secure-non-root)
[395.859690] Starting subtest: secure-non-root
[395.861647] Subtest secure-non-root: SKIP (0.000s)
[395.989114] [086/144] (664s left) gem_mmap_gtt (medium-copy-odd)
[396.052261] Subtest medium-copy-odd: SKIP (0.000s)
[396.083156] [087/144] (664s left) kms_lease (page-flip-implicit-plane)
[398.039979] Starting subtest: page-flip-implicit-plane
[398.041000] Starting dynamic subtest: pipe-A-HDMI-A-3
[398.387015] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.346s)
[398.419804] Starting dynamic subtest: pipe-B-HDMI-A-3
[398.673544] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.281s)
[398.686052] Starting dynamic subtest: pipe-C-HDMI-A-3
[398.915537] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.241s)
[398.925991] Starting dynamic subtest: pipe-D-HDMI-A-3
[399.143618] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.226s)
[399.144654] Subtest page-flip-implicit-plane: SUCCESS (1.104s)
[399.279065] [088/144] (660s left) gem_mmap_wc (copy)
[399.346210] Subtest copy: SKIP (0.000s)
[399.388123] [089/144] (660s left) kms_cdclk (mode-transition)
[401.347244] Starting subtest: mode-transition
[401.348221] Starting dynamic subtest: pipe-A-HDMI-A-3
[401.384516] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.037s)
[401.393154] Starting dynamic subtest: pipe-B-HDMI-A-3
[401.395149] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[401.403714] Starting dynamic subtest: pipe-C-HDMI-A-3
[401.405388] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[401.413593] Starting dynamic subtest: pipe-D-HDMI-A-3
[401.415227] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[401.416830] Subtest mode-transition: SKIP (0.047s)
[401.488911] [090/144] (658s left) kms_plane_scaling (planes-downscale-factor-0-5)
[403.485878] Starting subtest: planes-downscale-factor-0-5
[403.490757] Starting dynamic subtest: pipe-A-HDMI-A-3
[403.583365] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.093s)
[403.603258] Starting dynamic subtest: pipe-B-HDMI-A-3
[403.729916] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.140s)
[403.747171] Starting dynamic subtest: pipe-C-HDMI-A-3
[403.855196] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.119s)
[403.868921] Starting dynamic subtest: pipe-D-HDMI-A-3
[403.996960] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.137s)
[403.997872] Subtest planes-downscale-factor-0-5: SUCCESS (0.512s)
[404.138747] [091/144] (656s left) kms_vblank (ts-continuation-modeset-hang)
[406.102044] Starting subtest: ts-continuation-modeset-hang
[406.102882] Starting dynamic subtest: pipe-A-HDMI-A-3
[420.018865] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (13.916s)
[420.028929] Starting dynamic subtest: pipe-D-HDMI-A-3
[445.021403] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (25.000s)
[445.022366] Subtest ts-continuation-modeset-hang: SUCCESS (38.921s)
[445.127441] [092/144] (615s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[447.087912] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[447.089726] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[447.161806] [093/144] (613s left) gem_exec_params (rel-constants-invalid)
[447.271798] Starting subtest: rel-constants-invalid
[447.273065] Subtest rel-constants-invalid: SUCCESS (0.000s)
[447.379240] [094/144] (612s left) sysfs_timeslice_duration (timeout)
[447.472379] Starting subtest: timeout
[447.473448] Starting dynamic subtest: ccs2
[449.070516] Dynamic subtest ccs2: SUCCESS (1.597s)
[449.079337] Starting dynamic subtest: vecs0
[450.539393] Dynamic subtest vecs0: SUCCESS (1.468s)
[450.548079] Starting dynamic subtest: ccs0
[452.141520] Dynamic subtest ccs0: SUCCESS (1.601s)
[452.150073] Starting dynamic subtest: vcs0
[453.698550] Dynamic subtest vcs0: SUCCESS (1.557s)
[453.707068] Starting dynamic subtest: bcs0
[455.271653] Dynamic subtest bcs0: SUCCESS (1.572s)
[455.280205] Starting dynamic subtest: ccs3
[456.886451] Dynamic subtest ccs3: SUCCESS (1.614s)
[456.895229] Starting dynamic subtest: vecs1
[458.427566] Dynamic subtest vecs1: SUCCESS (1.541s)
[458.436150] Starting dynamic subtest: ccs1
[460.076537] Dynamic subtest ccs1: SUCCESS (1.648s)
[460.085390] Starting dynamic subtest: rcs0
[461.645585] Dynamic subtest rcs0: SUCCESS (1.568s)
[461.654193] Starting dynamic subtest: vcs1
[463.239548] Dynamic subtest vcs1: SUCCESS (1.594s)
[463.240526] Subtest timeout: SUCCESS (15.768s)
[463.346289] [095/144] (597s left) drm_fdinfo (busy-hang)
[463.396822] Starting subtest: busy-hang
[463.397805] Starting dynamic subtest: rcs0
[463.399684] Dynamic subtest rcs0: SKIP (0.001s)
[463.408515] Starting dynamic subtest: bcs0
[463.410530] Dynamic subtest bcs0: SKIP (0.000s)
[463.418932] Starting dynamic subtest: vcs0
[463.421050] Dynamic subtest vcs0: SKIP (0.000s)
[463.429174] Starting dynamic subtest: vcs1
[463.430810] Dynamic subtest vcs1: SKIP (0.000s)
[463.439187] Starting dynamic subtest: vecs0
[463.441418] Dynamic subtest vecs0: SKIP (0.000s)
[463.450671] Starting dynamic subtest: vecs1
[463.452891] Dynamic subtest vecs1: SKIP (0.000s)
[463.461242] Starting dynamic subtest: ccs0
[463.463724] Dynamic subtest ccs0: SKIP (0.000s)
[463.472323] Starting dynamic subtest: ccs1
[463.474756] Dynamic subtest ccs1: SKIP (0.000s)
[463.483022] Starting dynamic subtest: ccs2
[463.484914] Dynamic subtest ccs2: SKIP (0.000s)
[463.492917] Starting dynamic subtest: ccs3
[463.495358] Dynamic subtest ccs3: SKIP (0.000s)
[463.497713] Subtest busy-hang: SKIP (0.009s)
[463.510898] [096/144] (596s left) gem_pxp (reject-modify-context-protection-on)
[466.099382] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[466.171195] [097/144] (594s left) gem_ccs (block-multicopy-compressed)
[466.233767] Starting subtest: block-multicopy-compressed
[466.234640] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[466.268542] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.034s)
[466.277156] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[466.364029] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.095s)
[466.372708] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[466.377248] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.012s)
[466.385662] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[466.465779] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.088s)
[466.474170] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[466.479597] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.013s)
[466.487905] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[466.574523] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.094s)
[466.582955] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[466.588916] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.014s)
[466.597283] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[466.685050] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.095s)
[466.685922] Subtest block-multicopy-compressed: SUCCESS (0.452s)
[466.792390] [098/144] (593s left) kms_cursor_crc (cursor-alpha-transparent)
[468.748029] Starting subtest: cursor-alpha-transparent
[468.748908] Starting dynamic subtest: pipe-A-HDMI-A-3
[469.315871] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.567s)
[469.324843] Starting dynamic subtest: pipe-D-HDMI-A-3
[469.705492] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.389s)
[469.706452] Subtest cursor-alpha-transparent: SUCCESS (0.959s)
[470.120533] [099/144] (590s left) api_intel_bb (blit-noreloc-keep-cache)
[470.182584] Starting subtest: blit-noreloc-keep-cache
[470.209268] Subtest blit-noreloc-keep-cache: SUCCESS (0.027s)
[470.281951] [100/144] (590s left) kms_atomic (plane-overlay-legacy)
[472.234470] Starting subtest: plane-overlay-legacy
[472.235544] Starting dynamic subtest: pipe-A-HDMI-A-3
[472.922194] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.686s)
[472.923212] Subtest plane-overlay-legacy: SUCCESS (0.688s)
[473.077869] [101/144] (587s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[475.033546] Starting subtest: psr-rgb565-draw-mmap-wc
[475.035312] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[475.112589] [102/144] (585s left) gem_exec_flush (basic-wb-rw-default)
[475.234132] Subtest basic-wb-rw-default: SKIP (0.000s)
[475.268806] [103/144] (585s left) vc4/vc4_create_bo (create-bo-4096)
[475.341464] Subtest create-bo-4096: SKIP (0.000s)
[475.391237] [104/144] (585s left) kms_rotation_crc (sprite-rotation-270)
[477.352222] Starting subtest: sprite-rotation-270
[477.353976] Subtest sprite-rotation-270: SKIP (0.001s)
[477.408928] [105/144] (583s left) kms_ccs (pipe-a-ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[479.457973] Starting subtest: pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs
[479.459747] Subtest pipe-A-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[479.610049] [106/144] (580s left) sysfs_heartbeat_interval (idempotent)
[479.678940] Starting subtest: idempotent
[479.679796] Starting dynamic subtest: ccs2
[479.680614] Dynamic subtest ccs2: SUCCESS (0.001s)
[479.689359] Starting dynamic subtest: vecs0
[479.690280] Dynamic subtest vecs0: SUCCESS (0.001s)
[479.698662] Starting dynamic subtest: ccs0
[479.699465] Dynamic subtest ccs0: SUCCESS (0.001s)
[479.707562] Starting dynamic subtest: vcs0
[479.708357] Dynamic subtest vcs0: SUCCESS (0.001s)
[479.716471] Starting dynamic subtest: bcs0
[479.717304] Dynamic subtest bcs0: SUCCESS (0.001s)
[479.725590] Starting dynamic subtest: ccs3
[479.726423] Dynamic subtest ccs3: SUCCESS (0.001s)
[479.734524] Starting dynamic subtest: vecs1
[479.735320] Dynamic subtest vecs1: SUCCESS (0.001s)
[479.743980] Starting dynamic subtest: ccs1
[479.745322] Dynamic subtest ccs1: SUCCESS (0.001s)
[479.754068] Starting dynamic subtest: rcs0
[479.755188] Dynamic subtest rcs0: SUCCESS (0.001s)
[479.764296] Starting dynamic subtest: vcs1
[479.765332] Dynamic subtest vcs1: SUCCESS (0.001s)
[479.766164] Subtest idempotent: SUCCESS (0.013s)
[479.778664] [107/144] (580s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[479.839256] Starting subtest: y-tiled-to-vebox-x-tiled
[479.841033] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[480.024060] [108/144] (580s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[481.982298] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[481.984092] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[482.046785] [109/144] (578s left) kms_cursor_legacy (forked-bo)
[484.073022] Starting subtest: forked-bo
[484.073860] Starting dynamic subtest: pipe-A
[489.661533] Dynamic subtest pipe-A: SUCCESS (5.588s)
[489.674948] Starting dynamic subtest: pipe-B
[495.098308] Dynamic subtest pipe-B: SUCCESS (5.435s)
[495.122186] Starting dynamic subtest: pipe-C
[500.551629] Dynamic subtest pipe-C: SUCCESS (5.452s)
[500.572417] Starting dynamic subtest: pipe-D
[505.992570] Dynamic subtest pipe-D: SUCCESS (5.439s)
[506.015398] Starting dynamic subtest: all-pipes
[511.413357] Dynamic subtest all-pipes: SUCCESS (5.417s)
[511.414220] Subtest forked-bo: SUCCESS (27.338s)
[511.503670] [110/144] (549s left) kms_ccs (pipe-c-random-ccs-data-y-tiled-gen12-rc-ccs)
[513.581534] Starting subtest: pipe-C-random-ccs-data-y-tiled-gen12-rc-ccs
[513.584351] Subtest pipe-C-random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[513.702486] [111/144] (547s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[515.676389] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[515.678312] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[515.756733] [112/144] (544s left) gem_exec_schedule (preempt-self)
[515.913615] Starting subtest: preempt-self
[515.914640] Starting dynamic subtest: rcs0
[515.975035] Dynamic subtest rcs0: SUCCESS (0.061s)
[515.983567] Starting dynamic subtest: bcs0
[516.011117] Dynamic subtest bcs0: SUCCESS (0.035s)
[516.021067] Starting dynamic subtest: vcs0
[516.045316] Dynamic subtest vcs0: SUCCESS (0.033s)
[516.054123] Starting dynamic subtest: vcs1
[516.080510] Dynamic subtest vcs1: SUCCESS (0.034s)
[516.089461] Starting dynamic subtest: vecs0
[516.115340] Dynamic subtest vecs0: SUCCESS (0.034s)
[516.124122] Starting dynamic subtest: vecs1
[516.149522] Dynamic subtest vecs1: SUCCESS (0.034s)
[516.158208] Starting dynamic subtest: ccs0
[516.183619] Dynamic subtest ccs0: SUCCESS (0.033s)
[516.192065] Starting dynamic subtest: ccs1
[516.217657] Dynamic subtest ccs1: SUCCESS (0.033s)
[516.226121] Starting dynamic subtest: ccs2
[516.252483] Dynamic subtest ccs2: SUCCESS (0.034s)
[516.262868] Starting dynamic subtest: ccs3
[516.285000] Dynamic subtest ccs3: SUCCESS (0.030s)
[516.285999] Subtest preempt-self: SUCCESS (0.372s)
[516.694056] [113/144] (544s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[518.643210] Starting subtest: cursorA-vs-flipB-legacy
[518.645097] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[518.704530] [114/144] (542s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[520.680213] Starting subtest: primary-y-tiled-reflect-x-270
[520.682133] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[520.738122] [115/144] (540s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[520.836055] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[520.837413] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[520.933883] [116/144] (539s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[522.909988] Starting subtest: x-tiled-64bpp-rotate-270
[522.953983] Subtest x-tiled-64bpp-rotate-270: SKIP (0.044s)
[523.080681] [117/144] (537s left) syncobj_eventfd (invalid-bad-flags)
[523.193536] Starting subtest: invalid-bad-flags
[523.194479] Subtest invalid-bad-flags: SUCCESS (0.000s)
[523.285147] [118/144] (537s left) gem_exec_parallel (basic)
[523.391823] Starting subtest: basic
[523.392870] Starting dynamic subtest: rcs0
[524.851857] Dynamic subtest rcs0: SUCCESS (1.460s)
[524.861965] Starting dynamic subtest: bcs0
[526.263754] Dynamic subtest bcs0: SUCCESS (1.411s)
[526.273658] Starting dynamic subtest: vcs0
[527.698033] Dynamic subtest vcs0: SUCCESS (1.433s)
[527.708496] Starting dynamic subtest: vcs1
[529.124114] Dynamic subtest vcs1: SUCCESS (1.425s)
[529.134592] Starting dynamic subtest: vecs0
[530.539834] Dynamic subtest vecs0: SUCCESS (1.415s)
[530.549818] Starting dynamic subtest: vecs1
[531.940909] Dynamic subtest vecs1: SUCCESS (1.400s)
[531.952069] Starting dynamic subtest: ccs0
[533.347977] Dynamic subtest ccs0: SUCCESS (1.406s)
[533.358249] Starting dynamic subtest: ccs1
[534.760848] Dynamic subtest ccs1: SUCCESS (1.412s)
[534.770490] Starting dynamic subtest: ccs2
[536.163797] Dynamic subtest ccs2: SUCCESS (1.402s)
[536.173951] Starting dynamic subtest: ccs3
[537.579882] Dynamic subtest ccs3: SUCCESS (1.415s)
[537.580935] Subtest basic: SUCCESS (14.188s)
[537.825677] [119/144] (523s left) gem_ctx_persistence (heartbeat-stop)
[537.894119] Starting subtest: heartbeat-stop
[537.896085] Subtest heartbeat-stop: SKIP (0.000s)
[537.976191] [120/144] (522s left) gem_exec_store (basic)
[538.054735] Starting subtest: basic
[538.197443] Subtest basic: SUCCESS (0.142s)
[538.404086] [121/144] (522s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[540.355363] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[540.357233] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[540.445722] [122/144] (520s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[540.582900] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[540.616319] [123/144] (520s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[542.584149] Starting subtest: plane-all-modeset-transition-fencing
[542.585126] Starting dynamic subtest: pipe-A-HDMI-A-3
[560.951900] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (18.367s)
[561.033455] Starting dynamic subtest: pipe-B-HDMI-A-3
[575.138388] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (14.113s)
[575.194013] Subtest plane-all-modeset-transition-fencing: SUCCESS (32.611s)
[575.316239] [124/144] (485s left) kms_plane_cursor (primary)
[577.290173] Starting subtest: primary
[577.291799] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64
[580.544435] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.254s)
[580.604135] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128
[583.894684] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.300s)
[583.955465] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256
[587.244374] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.299s)
[587.355402] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64
[590.768094] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.427s)
[590.815684] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128
[594.084778] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.281s)
[594.126973] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256
[597.468085] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.350s)
[597.533381] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64
[600.890448] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.365s)
[600.932744] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128
[604.340635] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.416s)
[604.382179] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256
[607.740786] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.367s)
[607.807559] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64
[611.198966] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.400s)
[611.241544] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128
[614.632390] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.400s)
[614.674929] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256
[618.099110] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.433s)
[618.158531] Subtest primary: SUCCESS (40.869s)
[618.310241] [125/144] (442s left) gem_ctx_engines (independent)
[618.376495] Starting subtest: independent
[618.377489] Starting dynamic subtest: rcs0
[618.519494] Dynamic subtest rcs0: SUCCESS (0.136s)
[618.528176] Starting dynamic subtest: bcs0
[618.655471] Dynamic subtest bcs0: SUCCESS (0.134s)
[618.664060] Starting dynamic subtest: vcs0
[618.792784] Dynamic subtest vcs0: SUCCESS (0.139s)
[618.801448] Starting dynamic subtest: vcs1
[618.931175] Dynamic subtest vcs1: SUCCESS (0.138s)
[618.939759] Starting dynamic subtest: vecs0
[619.066188] Dynamic subtest vecs0: SUCCESS (0.132s)
[619.074806] Starting dynamic subtest: vecs1
[619.208232] Dynamic subtest vecs1: SUCCESS (0.142s)
[619.216788] Starting dynamic subtest: ccs0
[619.357178] Dynamic subtest ccs0: SUCCESS (0.146s)
[619.365710] Starting dynamic subtest: ccs1
[619.502934] Dynamic subtest ccs1: SUCCESS (0.144s)
[619.511458] Starting dynamic subtest: ccs2
[619.644401] Dynamic subtest ccs2: SUCCESS (0.144s)
[619.653078] Starting dynamic subtest: ccs3
[619.790047] Dynamic subtest ccs3: SUCCESS (0.144s)
[619.798754] Starting dynamic subtest: all-engines
[620.217131] Dynamic subtest all-engines: SUCCESS (0.427s)
[620.218033] Subtest independent: SUCCESS (1.835s)
[621.489787] [126/144] (439s left) kms_psr (fbc-pr-basic)
[623.453705] Subtest fbc-pr-basic: SKIP (0.000s)
[623.484492] [127/144] (437s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[625.555505] Starting subtest: pipe-D-crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[625.557337] Subtest pipe-D-crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[625.659292] [128/144] (435s left) gen3_render_tiledx_blits
[625.753828] [129/144] (435s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[627.713265] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[627.714160] Starting dynamic subtest: pipe-A-valid-mode
[627.751964] Dynamic subtest pipe-A-valid-mode: SKIP (0.037s)
[627.753682] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.039s)
[627.845027] [130/144] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[629.856131] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[629.857817] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[629.937104] [131/144] (431s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[630.058563] Starting subtest: etime-multi-wait-all-for-submit-submitted
[630.164416] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[630.259931] [132/144] (430s left) gem_softpin (full)
[630.348899] Starting subtest: full
[630.360575] Subtest full: SUCCESS (0.012s)
[630.493683] [133/144] (430s left) i915_pm_rpm (gem-idle)
[635.505313] Starting subtest: gem-idle
[641.812496] Subtest gem-idle: SUCCESS (6.308s)
[642.855544] [134/144] (418s left) kms_psr2_sf (plane-move-sf-dmg-area)
[642.960142] Subtest plane-move-sf-dmg-area: SKIP (0.000s)
[643.047194] [135/144] (418s left) kms_pm_rpm (system-suspend-modeset)
[647.579161] Starting subtest: system-suspend-modeset
[669.724509] Subtest system-suspend-modeset: SUCCESS (6.956s)
[671.837510] [136/144] (405s left) kms_ccs (pipe-c-bad-pixel-format-yf-tiled-ccs)
[673.869949] Starting subtest: pipe-C-bad-pixel-format-yf-tiled-ccs
[673.871731] Subtest pipe-C-bad-pixel-format-yf-tiled-ccs: SKIP (0.000s)
[673.999651] [137/144] (403s left) kms_async_flips (alternate-sync-async-flip)
[675.973599] Starting subtest: alternate-sync-async-flip
[676.134400] Starting dynamic subtest: pipe-A-HDMI-A-3
[678.400693] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.266s)
[678.579726] Starting dynamic subtest: pipe-B-HDMI-A-3
[680.658614] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.087s)
[680.819842] Starting dynamic subtest: pipe-C-HDMI-A-3
[682.892514] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.080s)
[683.062254] Starting dynamic subtest: pipe-D-HDMI-A-3
[685.141531] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.087s)
[685.142601] Subtest alternate-sync-async-flip: SUCCESS (9.169s)
[685.423517] [138/144] (392s left) vgem_basic (unload)
[685.470835] Starting subtest: unload
[714.382376] Subtest unload: SUCCESS (28.911s)
[714.483424] [139/144] (363s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-rc-ccs)
[716.568074] Starting subtest: pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs
[716.569880] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[716.673844] [140/144] (360s left) kms_vblank (ts-continuation-idle)
[718.643696] Starting subtest: ts-continuation-idle
[718.644667] Starting dynamic subtest: pipe-A-HDMI-A-3
[718.908770] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.264s)
[718.951148] Starting dynamic subtest: pipe-D-HDMI-A-3
[719.130856] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.210s)
[719.132005] Subtest ts-continuation-idle: SUCCESS (0.488s)
[719.237689] [141/144] (358s left) vc4/vc4_wait_seqno (bad-seqno-1ns)
[719.317728] Subtest bad-seqno-1ns: SKIP (0.000s)
[719.383198] [142/144] (358s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[721.363457] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[721.365310] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[721.438905] [143/144] (356s left) gem_mmap_offset (close-race)
[721.559008] Starting subtest: close-race
[741.629453] Subtest close-race: SUCCESS (20.071s)
[741.722317] [144/144] (336s left) kms_ccs (pipe-c-crc-primary-basic-yf-tiled-ccs)
[743.781235] Starting subtest: pipe-C-crc-primary-basic-yf-tiled-ccs
[743.782938] Subtest pipe-C-crc-primary-basic-yf-tiled-ccs: SKIP (0.000s)
[743.902908] Closing watchdogs
Done.