[61.041341] Initializing watchdogs
[61.041395]   /dev/watchdog0
[61.054904] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4c8a Intel Rocketlake (Gen12) RocketLake-S GT1 [UHD Graphics 750]
[61.059861] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.062078] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.063805] [001/132] (960s left) syncobj_timeline (wait-for-submit-snapshot)
[61.094439] Starting subtest: wait-for-submit-snapshot
[61.177866] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[61.313543] [002/132] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[61.410604] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[61.411244] Starting dynamic subtest: pipe-A-HDMI-A-1
[61.427053] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[61.431175] Starting dynamic subtest: pipe-B-HDMI-A-1
[61.447039] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[61.451094] Starting dynamic subtest: pipe-C-HDMI-A-1
[61.466984] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[61.468210] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[61.707635] [003/132] (959s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[61.813678] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[63.941275] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (2.128s)
[64.155455] [004/132] (957s left) kms_big_fb (linear-8bpp-rotate-270)
[64.261967] Starting subtest: linear-8bpp-rotate-270
[64.338140] Subtest linear-8bpp-rotate-270: SKIP (0.076s)
[64.517286] [005/132] (957s left) kms_busy (extended-modeset-hang-newfb)
[64.622312] Starting subtest: extended-modeset-hang-newfb
[64.623701] Starting dynamic subtest: pipe-A
[88.754037] Dynamic subtest pipe-A: SUCCESS (24.130s)
[88.759616] Starting dynamic subtest: pipe-C
[112.799855] Dynamic subtest pipe-C: SUCCESS (24.044s)
[112.801366] Subtest extended-modeset-hang-newfb: SUCCESS (48.179s)
[113.052746] [006/132] (908s left) perf (oa-exponents)
[113.185045] Starting subtest: oa-exponents
[113.185697] Starting dynamic subtest: 0-rcs0
[118.498110] Dynamic subtest 0-rcs0: SUCCESS (5.279s)
[118.499346] Subtest oa-exponents: SUCCESS (5.279s)
[118.565096] [007/132] (903s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[118.699870] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[120.082281] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.382s)
[120.320263] [008/132] (901s left) kms_pipe_crc_basic (suspend-read-crc)
[120.417198] Starting subtest: suspend-read-crc
[120.417849] Starting dynamic subtest: pipe-A-HDMI-A-1
[137.882174] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (15.923s)
[137.887778] Starting dynamic subtest: pipe-B-HDMI-A-1
[155.890879] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.837s)
[155.897068] Starting dynamic subtest: pipe-C-HDMI-A-1
[173.895003] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.924s)
[173.895652] Subtest suspend-read-crc: SUCCESS (21.687s)
[184.119816] [009/132] (847s left) perf_pmu (interrupts-sync)
[184.167843] Starting subtest: interrupts-sync
[185.349998] Subtest interrupts-sync: SUCCESS (1.124s)
[185.516014] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[185.519231] [010/132] (846s left) gem_exec_reloc (basic-gtt-active)
[185.550270] Subtest basic-gtt-active: SKIP (0.000s)
[185.626031] [011/132] (846s left) kms_flip (modeset-vs-vblank-race)
[185.724960] Starting subtest: modeset-vs-vblank-race
[185.726861] Starting dynamic subtest: A-HDMI-A1
[189.712554] Dynamic subtest A-HDMI-A1: SUCCESS (3.872s)
[189.731349] Starting dynamic subtest: B-HDMI-A1
[193.584786] Dynamic subtest B-HDMI-A1: SUCCESS (3.803s)
[193.604953] Starting dynamic subtest: C-HDMI-A1
[197.500492] Dynamic subtest C-HDMI-A1: SUCCESS (3.871s)
[197.504385] Subtest modeset-vs-vblank-race: SUCCESS (11.557s)
[197.717709] [012/132] (834s left) gem_sync (basic-each)
[197.762447] Starting subtest: basic-each
[199.867827] Subtest basic-each: SUCCESS (2.091s)
[200.125315] [013/132] (832s left) gem_ctx_persistence (legacy-engines-mixed)
[200.158402] Starting subtest: legacy-engines-mixed
[200.159276] Starting dynamic subtest: render
[200.217838] Dynamic subtest render: SUCCESS (0.058s)
[200.224043] Starting dynamic subtest: bsd
[200.288205] Dynamic subtest bsd: SUCCESS (0.069s)
[200.297195] Starting dynamic subtest: blt
[200.362757] Dynamic subtest blt: SUCCESS (0.073s)
[200.369004] Starting dynamic subtest: vebox
[200.411164] Dynamic subtest vebox: SUCCESS (0.047s)
[200.411859] Subtest legacy-engines-mixed: SUCCESS (0.252s)
[200.528149] [014/132] (831s left) kms_plane (plane-panning-bottom-right)
[200.628445] Starting subtest: plane-panning-bottom-right
[200.630000] Starting dynamic subtest: pipe-A
[201.169506] Dynamic subtest pipe-A: SUCCESS (0.537s)
[201.176835] Starting dynamic subtest: pipe-B
[201.611555] Dynamic subtest pipe-B: SUCCESS (0.439s)
[201.612184] Subtest plane-panning-bottom-right: SUCCESS (0.978s)
[201.830667] [015/132] (830s left) prime_vgem (wait)
[201.897837] Starting subtest: wait
[201.898564] Starting dynamic subtest: rcs0
[201.942571] Dynamic subtest rcs0: SUCCESS (0.045s)
[201.958544] Starting dynamic subtest: bcs0
[202.008884] Dynamic subtest bcs0: SUCCESS (0.064s)
[202.030384] Starting dynamic subtest: vcs0
[202.032121] Dynamic subtest vcs0: SUCCESS (0.021s)
[202.039197] Starting dynamic subtest: vecs0
[202.065205] Dynamic subtest vecs0: SUCCESS (0.032s)
[202.066658] Subtest wait: SUCCESS (0.169s)
[202.250371] [016/132] (830s left) i915_query (query-topology-matches-eu-total)
[202.279378] Starting subtest: query-topology-matches-eu-total
[202.280072] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[202.422179] [017/132] (829s left) syncobj_timeline (reset-signaled)
[202.450758] Starting subtest: reset-signaled
[202.451462] Subtest reset-signaled: SUCCESS (0.000s)
[202.592786] [018/132] (829s left) syncobj_timeline (multi-wait-all-available-signaled)
[202.621710] Starting subtest: multi-wait-all-available-signaled
[202.622411] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[202.765745] [019/132] (829s left) kms_cursor_crc (cursor-random-256x256)
[202.866164] Starting subtest: cursor-random-256x256
[202.869561] Starting dynamic subtest: pipe-A-HDMI-A-1
[207.104821] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.222s)
[207.131248] Starting dynamic subtest: pipe-C-HDMI-A-1
[211.213429] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (4.081s)
[211.214060] Subtest cursor-random-256x256: SUCCESS (8.328s)
[211.411634] [020/132] (821s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[211.447331] Starting subtest: mixed-tiled-to-y-tiled-ccs
[211.447951] Starting dynamic subtest: smem
[211.563196] Dynamic subtest smem: SUCCESS (0.114s)
[211.563870] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.114s)
[211.801729] [021/132] (820s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[211.898886] Starting subtest: primary-y-tiled-reflect-x-180
[221.667656] Subtest primary-y-tiled-reflect-x-180: SUCCESS (9.757s)
[221.920140] [022/132] (810s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[221.952285] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[221.952942] Starting dynamic subtest: smem
[222.026062] Dynamic subtest smem: SUCCESS (0.073s)
[222.026744] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (0.074s)
[222.280629] [023/132] (810s left) gem_exec_schedule (reorder-wide)
[222.444829] Starting subtest: reorder-wide
[222.445817] Starting dynamic subtest: rcs0
[222.505150] Dynamic subtest rcs0: SUCCESS (0.059s)
[222.516561] Starting dynamic subtest: bcs0
[222.564318] Dynamic subtest bcs0: SUCCESS (0.057s)
[222.575602] Starting dynamic subtest: vcs0
[222.622499] Dynamic subtest vcs0: SUCCESS (0.057s)
[222.633837] Starting dynamic subtest: vecs0
[222.681499] Dynamic subtest vecs0: SUCCESS (0.057s)
[222.682544] Subtest reorder-wide: SUCCESS (0.237s)
[222.944036] [024/132] (809s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[223.044224] Starting subtest: fbc-indfb-scaledprimary
[226.596614] Subtest fbc-indfb-scaledprimary: SUCCESS (3.550s)
[226.837014] [025/132] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[226.938201] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[226.939422] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[227.102570] [026/132] (805s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[227.199198] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[227.200840] Starting dynamic subtest: pipe-A-HDMI-A-1
[227.203343] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[227.209608] Starting dynamic subtest: pipe-B-HDMI-A-1
[227.212040] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[227.218140] Starting dynamic subtest: pipe-C-HDMI-A-1
[227.220615] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[227.221843] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[227.494346] [027/132] (805s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[227.595628] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[227.647534] [028/132] (805s left) kms_cursor_crc (cursor-random-64x21)
[227.746463] Starting subtest: cursor-random-64x21
[227.749456] Starting dynamic subtest: pipe-A-HDMI-A-1
[231.977791] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.225s)
[232.004854] Starting dynamic subtest: pipe-C-HDMI-A-1
[236.101754] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (4.100s)
[236.102401] Subtest cursor-random-64x21: SUCCESS (8.350s)
[236.330720] [029/132] (796s left) prime_mmap (test_dup)
[236.362592] Starting subtest: test_dup
[236.363205] Starting dynamic subtest: test_dup-smem
[236.401951] Dynamic subtest test_dup-smem: SUCCESS (0.040s)
[236.402638] Subtest test_dup: SUCCESS (0.041s)
[236.532547] [030/132] (796s left) gem_exec_schedule (u-submit-late-slice)
[236.569663] Starting subtest: u-submit-late-slice
[236.570299] Starting dynamic subtest: rcs0
[236.590195] Dynamic subtest rcs0: SUCCESS (0.020s)
[236.596867] Starting dynamic subtest: bcs0
[236.611841] Dynamic subtest bcs0: SUCCESS (0.021s)
[236.619566] Starting dynamic subtest: vcs0
[236.633826] Dynamic subtest vcs0: SUCCESS (0.021s)
[236.640648] Starting dynamic subtest: vecs0
[236.652840] Dynamic subtest vecs0: SUCCESS (0.018s)
[236.653553] Subtest u-submit-late-slice: SUCCESS (0.083s)
[237.033284] [031/132] (795s left) syncobj_timeline (etime-multi-wait-all-submitted)
[237.062100] Starting subtest: etime-multi-wait-all-submitted
[237.170901] Subtest etime-multi-wait-all-submitted: SUCCESS (0.109s)
[237.310343] [032/132] (795s left) fbdev (write)
[237.341878] Starting subtest: write
[237.756657] Subtest write: SUCCESS (0.406s)
[237.867667] [033/132] (795s left) syncobj_wait (invalid-signal-zero-handles)
[237.897031] Starting subtest: invalid-signal-zero-handles
[237.897722] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[238.032917] [034/132] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[238.133311] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[238.134519] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[238.302722] [035/132] (794s left) gem_exec_balancer (sliced)
[238.337401] Starting subtest: sliced
[239.473827] Subtest sliced: SUCCESS (1.127s)
[239.729529] [036/132] (793s left) gem_ccs (large-ctrl-surf-copy)
[239.760347] Starting subtest: large-ctrl-surf-copy
[239.761684] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[239.900737] [037/132] (793s left) gem_fenced_exec_thrash (2-spare-fences)
[239.931960] Starting subtest: 2-spare-fences
[242.090271] Subtest 2-spare-fences: SUCCESS (2.152s)
[242.269758] [038/132] (790s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[242.367661] Starting subtest: basic-busy-flip-before-cursor-varying-size
[242.369010] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[242.494545] [039/132] (790s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[242.600056] Starting subtest: 4-tiled-8bpp-rotate-0
[242.601260] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[242.765102] [040/132] (790s left) gem_mmap_wc (copy)
[242.793598] Starting subtest: copy
[242.886942] Subtest copy: SUCCESS (0.094s)
[243.030802] [041/132] (790s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[243.128415] Starting subtest: cursor-vs-flip-toggle
[273.836906] Subtest cursor-vs-flip-toggle: SUCCESS (30.696s)
[274.061219] [042/132] (759s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[274.172852] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[274.174076] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[274.325556] [043/132] (759s left) kms_addfb_basic (unused-handle)
[274.354284] Starting subtest: unused-handle
[274.354996] Subtest unused-handle: SUCCESS (0.000s)
[274.592445] [044/132] (758s left) gem_ctx_shared (q-smoketest-all)
[274.628188] Starting subtest: Q-smoketest-all
[306.912042] Subtest Q-smoketest-all: SUCCESS (32.274s)
[307.146931] [045/132] (726s left) kms_flip (2x-flip-vs-expired-vblank)
[307.245148] Starting subtest: 2x-flip-vs-expired-vblank
[307.246682] Subtest 2x-flip-vs-expired-vblank: SKIP (0.002s)
[307.403302] [046/132] (726s left) kms_force_connector_basic (force-edid)
[307.566684] Starting subtest: force-edid
[307.768165] Subtest force-edid: SUCCESS (0.202s)
[308.053770] [047/132] (725s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[308.170429] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[309.484093] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.313s)
[309.725922] [048/132] (723s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[309.824494] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[309.825138] Starting dynamic subtest: pipe-A
[309.973291] Dynamic subtest pipe-A: SUCCESS (0.149s)
[309.992063] Starting dynamic subtest: pipe-B
[310.120708] Dynamic subtest pipe-B: SUCCESS (0.145s)
[310.135871] Starting dynamic subtest: pipe-C
[310.267865] Dynamic subtest pipe-C: SUCCESS (0.144s)
[310.272916] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.446s)
[310.543020] [049/132] (723s left) kms_chamelium_audio (hdmi-audio)
[310.694495] Subtest hdmi-audio: SKIP (0.000s)
[310.777889] [050/132] (722s left) gem_set_tiling_vs_gtt
[311.268048] [051/132] (722s left) gem_lmem_swapping (massive)
[311.298165] Subtest massive: SKIP (0.000s)
[311.368413] [052/132] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[311.468304] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[311.469526] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[311.648455] [053/132] (722s left) prime_busy (after)
[311.679002] Starting subtest: after
[311.682826] Starting dynamic subtest: rcs0
[311.726757] Dynamic subtest rcs0: SUCCESS (0.044s)
[311.743502] Starting dynamic subtest: bcs0
[311.800946] Dynamic subtest bcs0: SUCCESS (0.072s)
[311.823314] Starting dynamic subtest: vcs0
[311.824033] Dynamic subtest vcs0: SUCCESS (0.020s)
[311.832211] Starting dynamic subtest: vecs0
[311.842638] Dynamic subtest vecs0: SUCCESS (0.017s)
[311.954380] Subtest after: SUCCESS (0.273s)
[312.103001] [054/132] (721s left) syncobj_wait (invalid-signal-illegal-handle)
[312.131341] Starting subtest: invalid-signal-illegal-handle
[312.132020] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[312.273196] [055/132] (721s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[312.370441] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[312.371082] Starting dynamic subtest: pipe-A-valid-mode
[312.427448] Dynamic subtest pipe-A-valid-mode: SKIP (0.056s)
[312.428760] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.057s)
[312.598218] [056/132] (721s left) gem_gtt_cpu_tlb
[312.788646] [057/132] (721s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[312.889408] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[312.890633] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[313.055182] [058/132] (721s left) gen9_exec_parse (batch-zero-length)
[313.085743] Subtest batch-zero-length: SKIP (0.000s)
[313.124947] [059/132] (721s left) gem_softpin (evict-snoop-interruptible)
[313.157681] Starting subtest: evict-snoop-interruptible
[313.158938] Subtest evict-snoop-interruptible: SKIP (0.000s)
[313.300325] [060/132] (720s left) dmabuf_sync_file (export-basic)
[313.347492] Starting subtest: export-basic
[313.348456] Subtest export-basic: SUCCESS (0.002s)
[313.471611] [061/132] (720s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[313.569417] Starting subtest: fb-8bpc-vs-panel-6bpc
[313.570070] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.622409] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.051s)
[313.623643] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.053s)
[313.852305] [062/132] (720s left) syncobj_timeline (host-signal-ordered)
[313.881095] Starting subtest: host-signal-ordered
[313.881724] Subtest host-signal-ordered: SUCCESS (0.000s)
[314.023695] [063/132] (720s left) kms_chamelium_hpd (common-hpd-after-suspend)
[314.175188] Subtest common-hpd-after-suspend: SKIP (0.000s)
[314.258309] [064/132] (720s left) kms_flip (2x-flip-vs-fences)
[314.356419] Starting subtest: 2x-flip-vs-fences
[314.360313] Subtest 2x-flip-vs-fences: SKIP (0.004s)
[314.560212] [065/132] (719s left) perf (mi-rpc)
[314.688314] Starting subtest: mi-rpc
[314.689580] Subtest mi-rpc: SKIP (0.000s)
[314.729238] [066/132] (719s left) sw_sync (sync_random_merge)
[314.756551] Starting subtest: sync_random_merge
[314.805977] Subtest sync_random_merge: SUCCESS (0.049s)
[314.918222] [067/132] (719s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[315.026842] Starting subtest: psr-rgb101010-draw-pwrite
[315.028124] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[315.184732] [068/132] (719s left) kms_getfb (getfb2-handle-closed)
[315.282353] Starting subtest: getfb2-handle-closed
[315.283008] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[315.452995] [069/132] (719s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[315.553371] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[315.554608] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[315.717389] [070/132] (718s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[315.746387] Starting subtest: invalid-smem-bo-on-discrete
[315.747625] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[316.002202] [071/132] (718s left) perf (gen12-invalid-class-instance)
[316.130394] Starting subtest: gen12-invalid-class-instance
[316.136655] Subtest gen12-invalid-class-instance: SUCCESS (0.006s)
[316.168848] [072/132] (718s left) gem_exec_schedule (implicit-read-write)
[316.205358] Starting subtest: implicit-read-write
[316.206029] Starting dynamic subtest: rcs0
[316.253550] Dynamic subtest rcs0: SUCCESS (0.048s)
[316.265485] Starting dynamic subtest: bcs0
[316.305455] Dynamic subtest bcs0: SUCCESS (0.050s)
[316.318605] Starting dynamic subtest: vcs0
[316.357607] Dynamic subtest vcs0: SUCCESS (0.050s)
[316.370885] Starting dynamic subtest: vecs0
[316.410516] Dynamic subtest vecs0: SUCCESS (0.051s)
[316.411907] Subtest implicit-read-write: SUCCESS (0.207s)
[316.780902] [073/132] (717s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[316.878092] Starting subtest: addfb25-framebuffer-vs-set-tiling
[316.878744] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[317.043832] [074/132] (717s left) kms_atomic (plane-cursor-legacy)
[317.141319] Starting subtest: plane-cursor-legacy
[317.142982] Starting dynamic subtest: pipe-A-HDMI-A-1
[317.313763] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.170s)
[317.314549] Subtest plane-cursor-legacy: SUCCESS (0.172s)
[317.539293] [075/132] (717s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[317.635946] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[317.637662] Starting dynamic subtest: pipe-A-HDMI-A-1
[317.643221] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[317.649709] Starting dynamic subtest: pipe-B-HDMI-A-1
[317.655212] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[317.661580] Starting dynamic subtest: pipe-C-HDMI-A-1
[317.666996] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[317.667603] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.005s)
[317.929838] [076/132] (716s left) gem_exec_balancer (bonded-pair)
[317.964718] Starting subtest: bonded-pair
[319.104952] Subtest bonded-pair: SUCCESS (1.131s)
[319.335760] [077/132] (715s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[319.435842] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[319.437085] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[319.597099] [078/132] (715s left) gem_ctx_exec (basic-invalid-context)
[319.625362] Starting subtest: basic-invalid-context
[319.626927] Subtest basic-invalid-context: SUCCESS (0.002s)
[319.824401] [079/132] (715s left) kms_content_protection (lic-type-0-hdcp14)
[319.926897] Starting subtest: lic-type-0-hdcp14
[319.936798] Subtest lic-type-0-hdcp14: SKIP (0.008s)
[320.121954] [080/132] (714s left) gem_eio (wait-immediate)
[320.157259] Starting subtest: wait-immediate
[320.301131] Subtest wait-immediate: SUCCESS (0.143s)
[320.507688] [081/132] (714s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[320.609412] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[320.611086] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.002s)
[320.787772] [082/132] (714s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[320.884360] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[320.885998] Starting dynamic subtest: pipe-A-valid-mode
[321.877753] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.992s)
[321.878404] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (0.993s)
[322.103849] [083/132] (713s left) kms_psr (psr2-basic)
[322.204177] Subtest psr2-basic: SKIP (0.000s)
[322.255308] [084/132] (712s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[322.352128] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[322.353755] Starting dynamic subtest: pipe-A-HDMI-A-1
[322.359843] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[322.366547] Starting dynamic subtest: pipe-B-HDMI-A-1
[322.372619] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[322.379245] Starting dynamic subtest: pipe-C-HDMI-A-1
[322.385221] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[322.386438] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[322.644846] [085/132] (712s left) kms_vblank (query-forked-busy)
[322.742101] Starting subtest: query-forked-busy
[322.743742] Starting dynamic subtest: pipe-A-HDMI-A-1
[325.532331] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.786s)
[325.555951] Starting dynamic subtest: pipe-C-HDMI-A-1
[328.272512] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.734s)
[328.273472] Subtest query-forked-busy: SUCCESS (5.530s)
[328.498265] [086/132] (706s left) kms_pm_dc (dc9-dpms)
[329.606725] Starting subtest: dc9-dpms
[332.928964] Subtest dc9-dpms: SKIP (3.286s)
[333.058385] [087/132] (702s left) gem_userptr_blits (set-cache-level)
[333.091079] Starting subtest: set-cache-level
[333.091728] Subtest set-cache-level: SUCCESS (0.000s)
[333.277887] [088/132] (702s left) gem_exec_fence (keep-in-fence)
[333.441276] Starting subtest: keep-in-fence
[333.442172] Starting dynamic subtest: rcs0
[333.513665] Dynamic subtest rcs0: SUCCESS (0.071s)
[333.525561] Starting dynamic subtest: bcs0
[333.546844] Dynamic subtest bcs0: SUCCESS (0.030s)
[333.565858] Starting dynamic subtest: vcs0
[333.580253] Dynamic subtest vcs0: SUCCESS (0.030s)
[333.595738] Starting dynamic subtest: vecs0
[333.612372] Dynamic subtest vecs0: SUCCESS (0.029s)
[333.615698] Subtest keep-in-fence: SUCCESS (0.172s)
[334.149946] [089/132] (701s left) kms_pm_rpm (modeset-pc8-residency-stress)
[335.570827] Starting subtest: modeset-pc8-residency-stress
[335.573047] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[335.820457] [090/132] (699s left) kms_psr (fbc-psr2-sprite-plane-move)
[335.919575] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[335.971869] [091/132] (699s left) gem_exec_create (forked)
[336.005814] Starting subtest: forked
[336.006467] Starting dynamic subtest: smem
[356.114979] Dynamic subtest smem: SUCCESS (20.103s)
[356.115920] Subtest forked: SUCCESS (20.104s)
[356.357354] [092/132] (679s left) kms_psr (pr-cursor-mmap-cpu)
[356.455524] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[356.505724] [093/132] (679s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[356.606322] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[356.607560] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[356.790401] [094/132] (678s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[356.891991] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[356.943497] [095/132] (678s left) gem_exec_reloc (basic-wc-read)
[356.974490] Subtest basic-wc-read: SKIP (0.000s)
[357.063922] [096/132] (678s left) kms_psr (psr-cursor-plane-move)
[357.162397] Subtest psr-cursor-plane-move: SKIP (0.000s)
[357.205303] [097/132] (678s left) kms_flip (basic-plain-flip)
[357.304474] Starting subtest: basic-plain-flip
[357.305119] Starting dynamic subtest: A-HDMI-A1
[358.181331] Dynamic subtest A-HDMI-A1: SUCCESS (0.875s)
[358.194764] Starting dynamic subtest: B-HDMI-A1
[359.030647] Dynamic subtest B-HDMI-A1: SUCCESS (0.845s)
[359.041151] Starting dynamic subtest: C-HDMI-A1
[359.858656] Dynamic subtest C-HDMI-A1: SUCCESS (0.824s)
[359.862877] Subtest basic-plain-flip: SUCCESS (2.558s)
[360.075337] [098/132] (675s left) kms_flip (plain-flip-fb-recreate)
[360.175577] Starting subtest: plain-flip-fb-recreate
[360.176226] Starting dynamic subtest: A-HDMI-A1
[370.686587] Dynamic subtest A-HDMI-A1: SUCCESS (10.507s)
[370.708796] Starting dynamic subtest: B-HDMI-A1
[381.180733] Dynamic subtest B-HDMI-A1: SUCCESS (10.486s)
[381.191309] Starting dynamic subtest: C-HDMI-A1
[391.650970] Dynamic subtest C-HDMI-A1: SUCCESS (10.463s)
[391.655162] Subtest plain-flip-fb-recreate: SUCCESS (31.469s)
[391.859599] [099/132] (643s left) i915_suspend (debugfs-reader)
[391.887910] Starting subtest: debugfs-reader
[410.361984] Subtest debugfs-reader: SUCCESS (4.134s)
[416.516568] [100/132] (625s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[416.621138] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[416.622408] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[416.794811] [101/132] (625s left) gem_exec_nop (basic-sequential)
[416.830545] Starting subtest: basic-sequential
[419.901810] Subtest basic-sequential: SUCCESS (3.070s)
[420.195085] [102/132] (621s left) gem_pxp (create-regular-buffer)
[420.290581] Starting subtest: create-regular-buffer
[420.291958] Subtest create-regular-buffer: SUCCESS (0.000s)
[420.457256] [103/132] (621s left) syncobj_basic (test-valid-cycle)
[420.485011] Starting subtest: test-valid-cycle
[420.485656] Subtest test-valid-cycle: SUCCESS (0.000s)
[420.628984] [104/132] (621s left) gem_exec_suspend (basic-s3-devices)
[420.663129] Starting subtest: basic-S3-devices
[420.663816] Starting dynamic subtest: smem
[428.329126] Dynamic subtest smem: SUCCESS (7.663s)
[428.329903] Subtest basic-S3-devices: SUCCESS (7.664s)
[434.616263] [105/132] (613s left) template (a)
[434.658690] Starting subtest: A
[434.659332] Subtest A: SUCCESS (0.000s)
[434.800130] [106/132] (613s left) gem_mmap_gtt (bad-object)
[434.827801] Starting subtest: bad-object
[434.828438] Subtest bad-object: SUCCESS (0.000s)
[435.008393] [107/132] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[435.110024] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[435.111337] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[435.275378] [108/132] (613s left) api_intel_bb (intel-bb-blit-y)
[435.304249] Starting subtest: intel-bb-blit-y
[438.164441] Subtest intel-bb-blit-y: SUCCESS (2.851s)
[438.324371] [109/132] (609s left) kms_selftest (drm_format_helper)
[438.354128] Starting subtest: drm_format_helper
[438.363915] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[438.464818] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.099s)
[438.475930] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[438.541072] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.075s)
[438.552688] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[438.626451] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.085s)
[438.636854] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[438.715368] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.086s)
[438.728787] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[438.824042] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.107s)
[438.833726] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[438.941245] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.115s)
[438.962003] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[439.029241] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.084s)
[439.049021] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[439.131002] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.099s)
[439.151316] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[439.221221] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.087s)
[439.241213] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[439.341014] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.116s)
[439.351479] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[439.450296] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.105s)
[439.465508] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[439.553666] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.103s)
[439.573413] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[439.662135] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.105s)
[439.684374] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[439.757611] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.089s)
[439.776514] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[439.869632] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.108s)
[439.889835] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[439.975074] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.104s)
[439.982155] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[440.094909] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.118s)
[440.095908] Subtest drm_format_helper: SUCCESS (1.740s)
[440.321739] [110/132] (608s left) gem_mmap_offset (oob-read)
[440.351298] Starting subtest: oob-read
[440.351920] Subtest oob-read: SUCCESS (0.000s)
[440.510577] [111/132] (607s left) gem_spin_batch (resubmit-all)
[440.544291] Starting subtest: resubmit-all
[440.544929] Starting dynamic subtest: rcs0
[440.547849] Dynamic subtest rcs0: SUCCESS (0.003s)
[440.556229] Starting dynamic subtest: bcs0
[440.556904] Dynamic subtest bcs0: SUCCESS (0.001s)
[440.563935] Starting dynamic subtest: vcs0
[440.564564] Dynamic subtest vcs0: SUCCESS (0.001s)
[440.571323] Starting dynamic subtest: vecs0
[440.571945] Dynamic subtest vecs0: SUCCESS (0.001s)
[440.572555] Subtest resubmit-all: SUCCESS (0.009s)
[440.795367] [112/132] (607s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[440.893367] Starting subtest: cursorB-vs-flipA-toggle
[440.895628] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[441.018177] [113/132] (607s left) gen9_exec_parse (valid-registers)
[441.048146] Subtest valid-registers: SKIP (0.000s)
[441.100204] [114/132] (607s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[441.197070] Starting subtest: disable-crc-after-crtc
[441.198656] Starting dynamic subtest: pipe-A-HDMI-A-1
[441.785363] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.586s)
[441.794905] Starting dynamic subtest: pipe-B-HDMI-A-1
[442.215651] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.429s)
[442.223843] Starting dynamic subtest: pipe-C-HDMI-A-1
[442.645722] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.428s)
[442.646321] Subtest disable-crc-after-crtc: SUCCESS (1.448s)
[442.858303] [115/132] (605s left) gem_exec_fence (syncobj-unused-fence)
[443.160856] Starting subtest: syncobj-unused-fence
[443.163062] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[443.543396] [116/132] (605s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[443.644213] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[443.645418] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[443.827742] [117/132] (604s left) gem_set_tiling_vs_pwrite
[443.950946] [118/132] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[444.051232] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[444.052504] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[444.226088] [119/132] (604s left) vgem_basic (busy-fence)
[444.270035] Starting subtest: busy-fence
[444.270762] Subtest busy-fence: SUCCESS (0.000s)
[444.394750] [120/132] (604s left) i915_pm_rpm (debugfs-read)
[445.816052] Starting subtest: debugfs-read
[446.002172] Subtest debugfs-read: SUCCESS (0.187s)
[446.243562] [121/132] (602s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[446.347166] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[449.233561] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (2.886s)
[449.455802] [122/132] (599s left) perf_pmu (busy-start)
[449.488002] Starting subtest: busy-start
[449.488673] Starting dynamic subtest: rcs0
[452.034113] Dynamic subtest rcs0: SUCCESS (2.527s)
[452.045459] Starting dynamic subtest: bcs0
[454.564086] Dynamic subtest bcs0: SUCCESS (2.517s)
[454.575509] Starting dynamic subtest: vcs0
[457.084089] Dynamic subtest vcs0: SUCCESS (2.517s)
[457.095208] Starting dynamic subtest: vecs0
[459.604061] Dynamic subtest vecs0: SUCCESS (2.523s)
[459.605099] Subtest busy-start: SUCCESS (10.094s)
[459.717307] [123/132] (589s left) kms_addfb_basic (size-max)
[459.815125] Starting subtest: size-max
[459.815767] Subtest size-max: SUCCESS (0.000s)
[459.989234] [124/132] (588s left) kms_psr (fbc-pr-primary-blt)
[460.086820] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[460.137900] [125/132] (588s left) kms_color_pipeline (plane-ctm3x4)
[460.237281] Starting subtest: plane-ctm3x4
[460.283288] Starting dynamic subtest: pipe-A-HDMI-A-1
[460.601644] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.320s)
[460.707863] Starting dynamic subtest: pipe-B-HDMI-A-1
[461.004412] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.303s)
[461.114101] Starting dynamic subtest: pipe-C-HDMI-A-1
[461.410395] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.303s)
[461.455285] Subtest plane-ctm3x4: SUCCESS (1.218s)
[461.626069] [126/132] (587s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[461.777505] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[461.854478] [127/132] (587s left) api_intel_allocator (standalone)
[461.882967] Starting subtest: standalone
[461.897015] Subtest standalone: SUCCESS (0.014s)
[462.069363] [128/132] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[462.169430] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[462.170666] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[462.352622] [129/132] (586s left) kms_big_fb (y-tiled-addfb)
[462.458232] Starting subtest: y-tiled-addfb
[462.458874] Subtest y-tiled-addfb: SUCCESS (0.000s)
[462.620572] [130/132] (586s left) kms_prime (basic-crc-vgem)
[462.727628] Starting subtest: basic-crc-vgem
[462.728251] Starting dynamic subtest: second-to-first
[463.952243] Dynamic subtest second-to-first: SUCCESS (1.224s)
[463.956235] Subtest basic-crc-vgem: SUCCESS (1.226s)
[464.131121] [131/132] (585s left) i915_hangman (engine-error-state-capture)
[464.165332] Starting subtest: engine-error-state-capture
[464.166004] Starting dynamic subtest: rcs0
[468.516739] Dynamic subtest rcs0: SUCCESS (4.349s)
[468.530994] Starting dynamic subtest: bcs0
[472.481982] Dynamic subtest bcs0: SUCCESS (3.961s)
[472.494115] Starting dynamic subtest: vcs0
[476.507730] Dynamic subtest vcs0: SUCCESS (4.021s)
[476.521374] Starting dynamic subtest: vecs0
[480.553819] Dynamic subtest vecs0: SUCCESS (4.041s)
[480.557676] Subtest engine-error-state-capture: SUCCESS (16.385s)
[480.746519] [132/132] (568s left) kms_invalid_mode (bad-vsync-end)
[480.843366] Starting subtest: bad-vsync-end
[480.844011] Starting dynamic subtest: pipe-A-HDMI-A-1
[480.892399] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.048s)
[480.903138] Starting dynamic subtest: pipe-B-HDMI-A-1
[480.903788] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[480.910719] Starting dynamic subtest: pipe-C-HDMI-A-1
[480.911351] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[480.911990] Subtest bad-vsync-end: SUCCESS (0.055s)
[481.091651] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_busy
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_pipe_crc_basic
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_sync
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: fbdev
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: gem_ccs
results: parsing output: 36/ for test: gem_fenced_exec_thrash
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: gem_ctx_shared
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_force_connector_basic
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_chamelium_audio
results: parsing output: 49/ for test: gem_set_tiling_vs_gtt
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: prime_busy
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: gem_gtt_cpu_tlb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gen9_exec_parse
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: dmabuf_sync_file
results: parsing output: 60/ for test: kms_dither
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: sw_sync
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_getfb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_atomic
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ctx_exec
results: parsing output: 78/ for test: kms_content_protection
results: parsing output: 79/ for test: gem_eio
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_pm_dc
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_exec_create
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: i915_suspend
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_nop
results: parsing output: 101/ for test: gem_pxp
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: gem_exec_suspend
results: parsing output: 104/ for test: template
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: kms_selftest
results: parsing output: 109/ for test: gem_mmap_offset
results: parsing output: 110/ for test: gem_spin_batch
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_pipe_crc_basic
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_color_pipeline
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_prime
results: parsing output: 130/ for test: i915_hangman
results: parsing output: 131/ for test: kms_invalid_mode
Done.