[91.509745] Initializing watchdogs
[91.509911]   /dev/watchdog0
[91.549063] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[91.564146] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.571643] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.580205] [001/133] (960s left) kms_psr (psr2-sprite-render)
[91.788825] Subtest psr2-sprite-render: SKIP (0.000s)
[91.885924] [002/133] (960s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[92.657902] Starting subtest: syncobj-timeline-invalid-flags
[92.661965] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[92.923690] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[92.930202] [003/133] (959s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[93.045495] Starting subtest: etime-multi-wait-all-submitted-signaled
[93.149559] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[93.301073] [004/133] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[93.508076] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[96.687099] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SUCCESS (3.183s)
[96.897358] [005/133] (955s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[97.113364] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[97.119603] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[97.264373] [006/133] (955s left) gem_exec_schedule (preempt-queue-chain)
[97.406178] Starting subtest: preempt-queue-chain
[97.409533] Starting dynamic subtest: rcs0
[97.763733] Dynamic subtest rcs0: SUCCESS (0.349s)
[97.783345] Starting dynamic subtest: bcs0
[98.125340] Dynamic subtest bcs0: SUCCESS (0.366s)
[98.147149] Starting dynamic subtest: vcs0
[98.502221] Dynamic subtest vcs0: SUCCESS (0.378s)
[98.521544] Starting dynamic subtest: vecs0
[98.866419] Dynamic subtest vecs0: SUCCESS (0.363s)
[98.874268] Subtest preempt-queue-chain: SUCCESS (1.462s)
[99.293587] [007/133] (953s left) kms_rotation_crc (bad-pixel-format)
[99.494122] Starting subtest: bad-pixel-format
[103.460117] Subtest bad-pixel-format: SUCCESS (3.963s)
[103.724798] [008/133] (949s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[103.874796] Starting subtest: map-fixed-invalidate-overlap
[103.878116] Starting dynamic subtest: gtt
[104.120089] Dynamic subtest gtt: SUCCESS (0.245s)
[104.141196] Starting dynamic subtest: wb
[104.282139] Dynamic subtest wb: SUCCESS (0.162s)
[104.302476] Starting dynamic subtest: wc
[104.444096] Dynamic subtest wc: SUCCESS (0.161s)
[104.464342] Starting dynamic subtest: uc
[104.604097] Dynamic subtest uc: SUCCESS (0.160s)
[104.607460] Subtest map-fixed-invalidate-overlap: SUCCESS (0.731s)
[104.809083] [009/133] (948s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[105.003734] Starting subtest: cursor-rapid-movement-32x10
[105.228176] Subtest cursor-rapid-movement-32x10: SKIP (0.216s)
[105.390632] [010/133] (947s left) kms_joiner (basic-force-big-joiner)
[105.595341] Starting subtest: basic-force-big-joiner
[105.601651] Subtest basic-force-big-joiner: SKIP (0.000s)
[105.743457] [011/133] (947s left) perf_pmu (event-wait)
[105.861348] Starting subtest: event-wait
[105.865508] Starting dynamic subtest: rcs0
[105.872762] Dynamic subtest rcs0: SKIP (0.000s)
[105.879397] Subtest event-wait: SKIP (0.002s)
[106.020528] [012/133] (947s left) gem_exec_params (mmapped)
[106.132439] Starting subtest: mmapped
[106.144472] Subtest mmapped: SUCCESS (0.007s)
[106.303270] [013/133] (946s left) kms_addfb_basic (unused-offsets)
[106.407121] Starting subtest: unused-offsets
[106.410206] Subtest unused-offsets: SUCCESS (0.000s)
[106.640758] [014/133] (946s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[106.751151] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[106.755777] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[106.888239] [015/133] (946s left) kms_plane_multiple (2x-tiling-y)
[107.063063] Starting subtest: 2x-tiling-y
[107.070170] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[108.242123] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.175s)
[108.299305] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2
[109.392479] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.130s)
[109.439428] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1
[110.663549] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.248s)
[110.724962] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1
[111.875268] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.072s)
[111.971999] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[113.125084] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.331s)
[113.199985] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2
[114.237647] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.072s)
[114.296379] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1
[115.532534] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.274s)
[115.596638] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1
[116.677603] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.124s)
[116.735726] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2
[117.807961] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.109s)
[117.865222] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2
[118.893867] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.064s)
[118.958433] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1
[120.189436] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.258s)
[120.250571] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1
[121.301502] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.091s)
[121.319213] Subtest 2x-tiling-y: SUCCESS (14.256s)
[122.086959] [016/133] (931s left) kms_flip (flip-vs-fences)
[122.288165] Starting subtest: flip-vs-fences
[122.293554] Starting dynamic subtest: A-HDMI-A1
[128.027110] Dynamic subtest A-HDMI-A1: SUCCESS (5.734s)
[128.048441] Starting dynamic subtest: B-HDMI-A1
[133.451312] Dynamic subtest B-HDMI-A1: SUCCESS (5.421s)
[133.474853] Starting dynamic subtest: C-HDMI-A1
[138.859579] Dynamic subtest C-HDMI-A1: SUCCESS (5.401s)
[138.880257] Starting dynamic subtest: A-HDMI-A2
[144.267874] Dynamic subtest A-HDMI-A2: SUCCESS (5.404s)
[144.295266] Starting dynamic subtest: B-HDMI-A2
[149.677118] Dynamic subtest B-HDMI-A2: SUCCESS (5.394s)
[149.700148] Starting dynamic subtest: C-HDMI-A2
[155.165068] Dynamic subtest C-HDMI-A2: SUCCESS (5.493s)
[155.170200] Subtest flip-vs-fences: SUCCESS (32.876s)
[155.706434] [017/133] (897s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[155.899416] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[155.903687] Starting dynamic subtest: pipe-A
[156.255327] Dynamic subtest pipe-A: SUCCESS (0.355s)
[156.298319] Starting dynamic subtest: pipe-B
[156.640587] Dynamic subtest pipe-B: SUCCESS (0.382s)
[156.665033] Starting dynamic subtest: pipe-C
[156.717444] Dynamic subtest pipe-C: SUCCESS (0.075s)
[156.724023] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.817s)
[157.188950] [018/133] (896s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[157.411435] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[157.420615] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[157.553934] [019/133] (896s left) kms_pm_rpm (dpms-lpsp)
[159.481135] Starting subtest: dpms-lpsp
[159.491778] Subtest dpms-lpsp: SKIP (0.001s)
[159.882876] [020/133] (894s left) gem_sync (basic-many-each)
[160.038071] Starting subtest: basic-many-each
[162.446269] Subtest basic-many-each: SUCCESS (2.425s)
[162.719286] [021/133] (891s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[162.931849] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[162.938560] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[163.088175] [022/133] (891s left) syncobj_wait (invalid-reset-illegal-handle)
[163.198415] Starting subtest: invalid-reset-illegal-handle
[163.202351] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[163.351498] [023/133] (890s left) syncobj_timeline (wait-all-complex)
[163.464176] Starting subtest: wait-all-complex
[163.683297] Subtest wait-all-complex: SUCCESS (0.224s)
[163.840666] [024/133] (890s left) gem_ctx_shared (exec-shared-gtt)
[163.971869] Starting subtest: exec-shared-gtt
[163.975522] Starting dynamic subtest: rcs0
[163.981036] Dynamic subtest rcs0: SUCCESS (0.012s)
[164.001690] Starting dynamic subtest: bcs0
[164.005496] Dynamic subtest bcs0: SUCCESS (0.013s)
[164.028449] Starting dynamic subtest: vcs0
[164.032653] Dynamic subtest vcs0: SUCCESS (0.008s)
[164.053376] Starting dynamic subtest: vecs0
[164.057519] Dynamic subtest vecs0: SUCCESS (0.012s)
[164.061543] Subtest exec-shared-gtt: SUCCESS (0.062s)
[164.335322] [025/133] (890s left) gem_exec_balancer (persistence)
[164.601552] Starting subtest: persistence
[168.930103] Subtest persistence: SUCCESS (4.330s)
[169.085366] [026/133] (885s left) gem_userptr_blits (unsync-unmap-cycles)
[169.220066] Subtest unsync-unmap-cycles: SKIP (0.000s)
[169.414754] [027/133] (885s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[169.593078] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[169.600264] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[169.765752] [028/133] (885s left) perf (gen12-group-concurrent-oa-buffer-read)
[170.007069] Starting subtest: gen12-group-concurrent-oa-buffer-read
[180.051574] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.051s)
[180.165532] [029/133] (874s left) kms_prop_blob (basic)
[180.278544] Starting subtest: basic
[180.282804] Subtest basic: SUCCESS (0.000s)
[180.415682] [030/133] (874s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[180.607068] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[180.712898] [031/133] (874s left) sysfs_heartbeat_interval (mixed)
[180.832783] Starting subtest: mixed
[180.836136] Starting dynamic subtest: vecs0
[186.125966] Dynamic subtest vecs0: SUCCESS (5.288s)
[186.145981] Starting dynamic subtest: vcs0
[191.410172] Dynamic subtest vcs0: SUCCESS (5.278s)
[191.432134] Starting dynamic subtest: bcs0
[196.630902] Dynamic subtest bcs0: SUCCESS (5.222s)
[196.651834] Starting dynamic subtest: rcs0
[201.893047] Dynamic subtest rcs0: SUCCESS (5.261s)
[201.898253] Subtest mixed: SUCCESS (21.061s)
[202.082561] [032/133] (853s left) kms_cursor_crc (cursor-onscreen-256x256)
[202.287304] Starting subtest: cursor-onscreen-256x256
[202.348561] Starting dynamic subtest: pipe-A-HDMI-A-1
[205.086835] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.735s)
[205.217242] Starting dynamic subtest: pipe-C-HDMI-A-1
[207.600812] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.426s)
[207.608157] Subtest cursor-onscreen-256x256: SUCCESS (5.312s)
[207.982993] [033/133] (847s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[208.177069] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[208.293247] [034/133] (847s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[208.512816] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[211.018523] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SUCCESS (2.513s)
[211.246890] [035/133] (844s left) syncobj_wait (wait-delayed-signal)
[211.358956] Starting subtest: wait-delayed-signal
[211.464133] Subtest wait-delayed-signal: SUCCESS (0.105s)
[211.628505] [036/133] (843s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[211.743156] Starting subtest: multi-wait-all-for-submit-signaled
[211.746682] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[211.882852] [037/133] (843s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[212.081326] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[212.088250] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[212.232674] [038/133] (843s left) gem_exec_reloc (basic-gtt-wc)
[212.358147] Starting subtest: basic-gtt-wc
[212.374266] Subtest basic-gtt-wc: SUCCESS (0.020s)
[212.600344] [039/133] (843s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[212.817483] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[212.825086] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[212.962176] [040/133] (843s left) fbdev (unaligned-read)
[213.086992] Starting subtest: unaligned-read
[213.115978] Subtest unaligned-read: SUCCESS (0.029s)
[213.245579] [041/133] (842s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[213.369062] Starting subtest: yf-tiled-to-vebox-yf-tiled
[213.376527] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[213.628918] [042/133] (842s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[213.817778] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[213.940559] [043/133] (842s left) gen7_exec_parse (basic-allocation)
[214.067112] Subtest basic-allocation: SKIP (0.000s)
[214.185815] [044/133] (842s left) gem_exec_balancer (bonded-true-hang)
[214.437843] Starting subtest: bonded-true-hang
[218.595084] Subtest bonded-true-hang: SUCCESS (4.157s)
[218.745954] [045/133] (837s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[218.957825] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[218.965089] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[219.099203] [046/133] (837s left) gem_exec_params (rel-constants-invalid)
[219.222701] Starting subtest: rel-constants-invalid
[219.226554] Subtest rel-constants-invalid: SUCCESS (0.001s)
[219.381070] [047/133] (837s left) i915_query (test-query-geometry-subslices)
[219.489815] Starting subtest: test-query-geometry-subslices
[219.497998] Subtest test-query-geometry-subslices: SKIP (0.000s)
[219.662529] [048/133] (837s left) gem_pwrite_snooped
[219.946782] [049/133] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[220.160983] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[220.167435] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[220.316186] [050/133] (836s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[220.528239] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[220.534969] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[220.697410] [051/133] (836s left) kms_atomic_transition (modeset-transition-nonblocking)
[220.883766] Starting subtest: modeset-transition-nonblocking
[220.888225] Starting dynamic subtest: 1x-outputs
[224.408081] Dynamic subtest 1x-outputs: SUCCESS (3.522s)
[224.430470] Starting dynamic subtest: 2x-outputs
[231.770932] Dynamic subtest 2x-outputs: SUCCESS (7.356s)
[231.774749] Subtest modeset-transition-nonblocking: SUCCESS (10.884s)
[232.095380] [052/133] (825s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[232.298206] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[232.301459] Starting dynamic subtest: pipe-A-HDMI-A-1
[232.343456] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[232.384518] Starting dynamic subtest: pipe-A-HDMI-A-2
[232.433858] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[232.462093] Starting dynamic subtest: pipe-B-HDMI-A-1
[232.493361] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[232.514907] Starting dynamic subtest: pipe-B-HDMI-A-2
[232.547102] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[232.567984] Starting dynamic subtest: pipe-C-HDMI-A-1
[232.598335] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[232.619046] Starting dynamic subtest: pipe-C-HDMI-A-2
[232.652984] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[232.659179] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.032s)
[233.312983] [053/133] (824s left) kms_cursor_crc (cursor-sliding-32x32)
[233.505230] Starting subtest: cursor-sliding-32x32
[233.664295] Subtest cursor-sliding-32x32: SKIP (0.151s)
[233.836144] [054/133] (823s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[234.052610] Starting subtest: 4-tiled-8bpp-rotate-90
[234.061102] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[234.202276] [055/133] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[234.439564] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[234.446055] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[234.585568] [056/133] (823s left) gem_fence_thrash (bo-write-verify-threaded-x)
[234.693703] Starting subtest: bo-write-verify-threaded-x
[239.970581] Subtest bo-write-verify-threaded-x: SUCCESS (5.277s)
[240.130611] [057/133] (817s left) kms_universal_plane (disable-primary-vs-flip)
[240.315105] Starting subtest: disable-primary-vs-flip
[240.332324] Starting dynamic subtest: pipe-A-HDMI-A-1
[241.423376] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.101s)
[241.482256] Starting dynamic subtest: pipe-B-HDMI-A-2
[242.232756] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.799s)
[242.266610] Starting dynamic subtest: pipe-C-HDMI-A-1
[243.069212] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.825s)
[243.075386] Subtest disable-primary-vs-flip: SUCCESS (2.751s)
[243.437791] [058/133] (814s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[243.649049] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[245.123048] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.471s)
[245.434957] [059/133] (812s left) kms_feature_discovery (display-2x)
[245.631233] Starting subtest: display-2x
[245.634498] Subtest display-2x: SUCCESS (0.000s)
[245.774630] [060/133] (812s left) kms_flip (2x-dpms-vs-vblank-race)
[245.968381] Starting subtest: 2x-dpms-vs-vblank-race
[245.972068] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[250.644264] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (4.667s)
[250.671469] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[254.895213] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (4.154s)
[254.944043] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[259.022963] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (4.210s)
[259.026060] Subtest 2x-dpms-vs-vblank-race: SUCCESS (13.052s)
[259.376269] [061/133] (798s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[259.603952] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[259.610299] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[259.757809] [062/133] (798s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[259.970867] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[260.086184] [063/133] (798s left) kms_psr (pr-primary-render)
[260.283221] Subtest pr-primary-render: SKIP (0.000s)
[260.399654] [064/133] (798s left) kms_hdmi_inject (inject-4k)
[260.949186] Starting subtest: inject-4k
[261.257361] Subtest inject-4k: SUCCESS (0.298s)
[261.740108] [065/133] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[261.956769] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[261.962963] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[262.113730] [066/133] (796s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[262.235218] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[262.334862] [067/133] (796s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[262.444114] Starting subtest: multi-wait-all-available-submitted-signaled
[262.447468] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.002s)
[262.592306] [068/133] (796s left) gem_exec_reloc (basic-write-cpu-active)
[262.711926] Starting subtest: basic-write-cpu-active
[262.852281] Subtest basic-write-cpu-active: SUCCESS (0.140s)
[263.105163] [069/133] (795s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[263.296113] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[263.301865] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[263.439310] [070/133] (795s left) gem_pxp (create-regular-buffer)
[266.088235] Starting subtest: create-regular-buffer
[266.096514] Subtest create-regular-buffer: SKIP (0.000s)
[266.244928] [071/133] (792s left) kms_legacy_colorkey (basic)
[266.440577] Starting subtest: basic
[266.443707] Starting dynamic subtest: pipe-A
[266.474416] Dynamic subtest pipe-A: SUCCESS (0.034s)
[266.495627] Starting dynamic subtest: pipe-B
[266.513358] Dynamic subtest pipe-B: SUCCESS (0.035s)
[266.544617] Starting dynamic subtest: pipe-C
[266.547888] Dynamic subtest pipe-C: SUCCESS (0.001s)
[266.550977] Subtest basic: SUCCESS (0.085s)
[266.686645] [072/133] (792s left) core_getversion (all-cards)
[266.797514] Starting subtest: all-cards
[266.835226] Subtest all-cards: SUCCESS (0.045s)
[266.942349] [073/133] (792s left) api_intel_bb (crc32)
[267.046163] Starting subtest: crc32
[267.054157] Subtest crc32: SKIP (0.000s)
[267.198243] [074/133] (792s left) gem_spin_batch (resubmit-new-all)
[267.329083] Starting subtest: resubmit-new-all
[267.334249] Starting dynamic subtest: rcs0
[267.344226] Dynamic subtest rcs0: SUCCESS (0.013s)
[267.392765] Starting dynamic subtest: bcs0
[267.396874] Dynamic subtest bcs0: SUCCESS (0.010s)
[267.418236] Starting dynamic subtest: vcs0
[267.421978] Dynamic subtest vcs0: SUCCESS (0.010s)
[267.443218] Starting dynamic subtest: vecs0
[267.447466] Dynamic subtest vecs0: SUCCESS (0.011s)
[267.451440] Subtest resubmit-new-all: SUCCESS (0.056s)
[267.660294] [075/133] (791s left) gem_exec_schedule (preempt-user)
[267.802308] Starting subtest: preempt-user
[267.806065] Starting dynamic subtest: rcs0
[267.849630] Dynamic subtest rcs0: SUCCESS (0.049s)
[267.877416] Starting dynamic subtest: bcs0
[267.922775] Dynamic subtest bcs0: SUCCESS (0.069s)
[267.951721] Starting dynamic subtest: vcs0
[267.973434] Dynamic subtest vcs0: SUCCESS (0.048s)
[267.999928] Starting dynamic subtest: vecs0
[268.021698] Dynamic subtest vecs0: SUCCESS (0.046s)
[268.025952] Subtest preempt-user: SUCCESS (0.224s)
[268.428348] [076/133] (791s left) gem_media_vme
[268.672250] [077/133] (791s left) gem_basic (create-close)
[268.779619] Starting subtest: create-close
[268.787198] Subtest create-close: SUCCESS (0.000s)
[268.942848] [078/133] (790s left) prime_busy (hang-wait)
[269.062181] Starting subtest: hang-wait
[269.065217] Starting dynamic subtest: rcs0
[275.636801] Dynamic subtest rcs0: SUCCESS (6.572s)
[275.658384] Starting dynamic subtest: bcs0
[282.676642] Dynamic subtest bcs0: SUCCESS (7.034s)
[282.698568] Starting dynamic subtest: vcs0
[289.653146] Dynamic subtest vcs0: SUCCESS (6.971s)
[289.675337] Starting dynamic subtest: vecs0
[296.627226] Dynamic subtest vecs0: SUCCESS (6.971s)
[296.630803] Subtest hang-wait: SUCCESS (27.568s)
[296.801507] [079/133] (763s left) gem_ctx_persistence (engines-queued)
[296.935724] Starting subtest: engines-queued
[296.940204] Starting dynamic subtest: rcs0
[296.974113] Dynamic subtest rcs0: SUCCESS (0.044s)
[297.003334] Starting dynamic subtest: bcs0
[297.096094] Dynamic subtest bcs0: SUCCESS (0.118s)
[297.121700] Starting dynamic subtest: vcs0
[297.151242] Dynamic subtest vcs0: SUCCESS (0.052s)
[297.177981] Starting dynamic subtest: vecs0
[297.203113] Dynamic subtest vecs0: SUCCESS (0.048s)
[297.206807] Subtest engines-queued: SUCCESS (0.279s)
[297.363464] [080/133] (762s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[297.566432] Starting subtest: y-tiled-64bpp-rotate-270
[297.946306] Subtest y-tiled-64bpp-rotate-270: SKIP (0.374s)
[298.229738] [081/133] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[298.455170] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[300.958325] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.505s)
[301.174694] [082/133] (759s left) kms_chamelium_color (ctm-0-75)
[301.359308] Subtest ctm-0-75: SKIP (0.000s)
[301.483977] [083/133] (758s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[301.687295] Starting subtest: crc-primary-suspend-y-tiled-ccs
[301.691469] Starting dynamic subtest: pipe-A-HDMI-A-1