[63.556968] Initializing watchdogs
[63.557041]   /dev/watchdog0
[63.576984] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.587608] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.591575] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.593837] [001/133] (960s left) gem_mmap_offset (partial-unmap)
[63.676264] Starting subtest: partial-unmap
[63.677176] Starting dynamic subtest: lmem0
[63.686303] Dynamic subtest lmem0: SUCCESS (0.010s)
[63.694088] Starting dynamic subtest: smem0
[63.695088] Dynamic subtest smem0: SUCCESS (0.004s)
[63.696161] Subtest partial-unmap: SUCCESS (0.015s)
[63.856281] [002/133] (960s left) gem_exec_schedule (fairslice-all)
[63.953050] Starting subtest: fairslice-all
[66.072756] Subtest fairslice-all: SUCCESS (2.120s)
[66.494969] [003/133] (957s left) kms_color (invalid-degamma-lut-sizes)
[68.006009] Starting subtest: invalid-degamma-lut-sizes
[68.006949] Starting dynamic subtest: pipe-A
[68.063186] Dynamic subtest pipe-A: SUCCESS (0.058s)
[68.070610] Starting dynamic subtest: pipe-B
[68.071497] Dynamic subtest pipe-B: SUCCESS (0.001s)
[68.078947] Starting dynamic subtest: pipe-C
[68.079904] Dynamic subtest pipe-C: SUCCESS (0.000s)
[68.087437] Starting dynamic subtest: pipe-D
[68.088306] Dynamic subtest pipe-D: SUCCESS (0.000s)
[68.089208] Subtest invalid-degamma-lut-sizes: SUCCESS (0.060s)
[68.283035] [004/133] (956s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[69.790943] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[69.792773] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[70.016441] [005/133] (954s left) prime_mmap (test_forked)
[70.090759] Starting subtest: test_forked
[70.091593] Starting dynamic subtest: test_forked-smem
[70.145745] Dynamic subtest test_forked-smem: SUCCESS (0.055s)
[70.153290] Starting dynamic subtest: test_forked-lmem0
[70.339210] Dynamic subtest test_forked-lmem0: SUCCESS (0.193s)
[70.340169] Subtest test_forked: SUCCESS (0.248s)
[70.462651] [006/133] (954s left) kms_psr (psr-sprite-plane-onoff)
[71.963971] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[72.018455] [007/133] (952s left) gem_exec_fence (basic-wait-all)
[72.113606] Starting subtest: basic-wait-all
[72.253217] Subtest basic-wait-all: SUCCESS (0.139s)
[73.142770] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[73.144605] [008/133] (951s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[74.667667] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[74.669578] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[74.876559] [009/133] (949s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[76.399251] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[76.411414] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.013s)
[76.603309] [010/133] (948s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[76.703528] Starting subtest: single-wait-all-for-submit-signaled
[76.704478] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[76.908716] [011/133] (948s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[78.421296] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[78.422219] Starting dynamic subtest: pipe-A-HDMI-A-3
[78.430724] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[78.438539] Starting dynamic subtest: pipe-B-HDMI-A-3
[78.447250] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[78.454972] Starting dynamic subtest: pipe-C-HDMI-A-3
[78.463564] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[78.471075] Starting dynamic subtest: pipe-D-HDMI-A-3
[78.481388] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[78.483117] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[78.741304] [012/133] (946s left) syncobj_timeline (etime-multi-wait-all-submitted)
[78.814315] Starting subtest: etime-multi-wait-all-submitted
[78.915565] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s)
[79.089146] [013/133] (946s left) gem_caching (reads)
[79.169498] Starting subtest: reads
[82.194903] Subtest reads: SUCCESS (3.025s)
[82.372249] [014/133] (942s left) api_intel_allocator (reopen-fork)
[82.448224] Starting subtest: reopen-fork
[85.876903] Subtest reopen-fork: SUCCESS (3.429s)
[86.044440] [015/133] (939s left) gem_tiled_swapping (non-threaded)
[86.122940] Subtest non-threaded: SKIP (0.000s)
[86.190100] [016/133] (939s left) kms_lease (lease-revoke)
[87.698948] Starting subtest: lease-revoke
[87.699917] Starting dynamic subtest: pipe-A-HDMI-A-3
[87.778058] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.078s)
[87.786326] Starting dynamic subtest: pipe-B-HDMI-A-3
[87.824330] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.046s)
[87.832783] Starting dynamic subtest: pipe-C-HDMI-A-3
[87.871044] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.045s)
[87.879159] Starting dynamic subtest: pipe-D-HDMI-A-3
[87.918494] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.047s)
[87.919355] Subtest lease-revoke: SUCCESS (0.220s)
[88.109010] [017/133] (937s left) kms_psr (fbc-psr-sprite-blt)
[89.619949] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[89.673587] [018/133] (935s left) kms_atomic_interruptible (legacy-setmode)
[91.186412] Starting subtest: legacy-setmode
[91.187298] Starting dynamic subtest: pipe-A-HDMI-A-3
[97.379252] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.192s)
[97.380207] Subtest legacy-setmode: SUCCESS (6.194s)
[97.572474] [019/133] (927s left) gem_partial_pwrite_pread (writes-after-reads-display)
[97.653275] Subtest writes-after-reads-display: SKIP (0.000s)
[97.752327] [020/133] (927s left) i915_drm_fdinfo (memory-info-resident)
[97.820597] Starting subtest: memory-info-resident
[97.821479] Starting dynamic subtest: lmem0
[101.526834] Dynamic subtest lmem0: SUCCESS (3.705s)
[101.539421] Starting dynamic subtest: smem0
[105.501529] Dynamic subtest smem0: SUCCESS (3.974s)
[105.502457] Subtest memory-info-resident: SUCCESS (7.681s)
[105.627718] [021/133] (919s left) gem_create (busy-create)
[105.705393] Starting subtest: busy-create
[105.706300] Starting dynamic subtest: lmem0
[138.025538] Dynamic subtest lmem0: SUCCESS (32.320s)
[138.036192] Starting dynamic subtest: smem0
[170.279275] Dynamic subtest smem0: SUCCESS (32.253s)
[170.280157] Subtest busy-create: SUCCESS (64.574s)
[170.540468] [022/133] (855s left) syncobj_wait (multi-wait-signaled)
[170.619134] Starting subtest: multi-wait-signaled
[170.620069] Subtest multi-wait-signaled: SUCCESS (0.000s)
[170.804560] [023/133] (854s left) gem_lmem_swapping (verify-ccs)
[175.424937] Starting subtest: verify-ccs
[175.426163] Starting dynamic subtest: lmem0
[214.505307] Dynamic subtest lmem0: SUCCESS (39.080s)
[214.506220] Subtest verify-ccs: SUCCESS (39.081s)
[216.460428] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[216.461358] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[216.462793] [024/133] (809s left) kms_pm_rpm (pc8-residency)
[224.057767] Starting subtest: pc8-residency
[224.061119] Subtest pc8-residency: SKIP (0.000s)
[225.096751] [FACT kms_pm_rpm (pc8-residency)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[225.101241] [FACT kms_pm_rpm (pc8-residency)] new: kernel.kmod_is_loaded.i915: true
[225.105807] [025/133] (800s left) gem_tiled_pread_pwrite
[225.293065] [026/133] (800s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[226.802036] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[226.805264] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[226.962853] [027/133] (798s left) prime_self_import (reimport-vs-gem_close-race)
[227.042589] Starting subtest: reimport-vs-gem_close-race
[232.131482] Subtest reimport-vs-gem_close-race: SUCCESS (5.089s)
[232.342165] [028/133] (793s left) gem_exec_fence (syncobj-invalid-flags)
[232.844916] Starting subtest: syncobj-invalid-flags
[232.845828] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[233.301208] [029/133] (792s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[234.812997] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[234.813958] Starting dynamic subtest: pipe-A-HDMI-A-3
[234.822427] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[234.830653] Starting dynamic subtest: pipe-B-HDMI-A-3
[234.839315] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[234.847491] Starting dynamic subtest: pipe-C-HDMI-A-3
[234.856120] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[234.863930] Starting dynamic subtest: pipe-D-HDMI-A-3
[234.874217] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[234.876546] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[235.118614] [030/133] (791s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[236.629272] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[236.630167] Starting dynamic subtest: pipe-A-valid-mode
[238.163432] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.534s)
[238.164327] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.535s)
[238.357118] [031/133] (787s left) kms_pm_backlight (bad-brightness)
[239.877086] Subtest bad-brightness: SKIP (0.000s)
[239.931369] [032/133] (786s left) gem_pxp (reject-modify-context-protection-off-1)
[242.532191] Starting subtest: reject-modify-context-protection-off-1
[242.534977] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[242.667362] [033/133] (783s left) gem_exec_params (invalid-fence-in)
[242.750237] Starting subtest: invalid-fence-in
[242.751146] Subtest invalid-fence-in: SUCCESS (0.000s)
[242.878580] [034/133] (783s left) gem_exec_reloc (basic-write-read-noreloc)
[242.962817] Subtest basic-write-read-noreloc: SKIP (0.000s)
[243.033371] [035/133] (783s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[244.552211] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[244.553960] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[244.741254] [036/133] (781s left) device_reset (unbind-reset-rebind)
[244.843196] Starting subtest: unbind-reset-rebind
[248.584374] Subtest unbind-reset-rebind: SUCCESS (3.742s)
[248.634081] [037/133] (777s left) gem_ctx_exec (basic-nohangcheck)
[248.710942] Starting subtest: basic-nohangcheck
[249.032257] Subtest basic-nohangcheck: SUCCESS (0.321s)
[249.200376] [038/133] (777s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[250.707168] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[250.708016] Starting dynamic subtest: pipe-A-HDMI-A-3
[250.716411] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[250.725193] Starting dynamic subtest: pipe-B-HDMI-A-3
[250.733587] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[250.742237] Starting dynamic subtest: pipe-C-HDMI-A-3
[250.750537] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[250.759358] Starting dynamic subtest: pipe-D-HDMI-A-3
[250.770143] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[250.772452] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[251.010722] [039/133] (775s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[252.526468] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[252.527347] Starting dynamic subtest: pipe-A-HDMI-A-3
[252.536052] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[252.544983] Starting dynamic subtest: pipe-B-HDMI-A-3
[252.554156] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[252.562932] Starting dynamic subtest: pipe-C-HDMI-A-3
[252.571243] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[252.579504] Starting dynamic subtest: pipe-D-HDMI-A-3
[252.590136] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[252.592150] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[252.853024] [040/133] (773s left) syncobj_basic (bad-create-flags)
[252.934983] Starting subtest: bad-create-flags
[252.935872] Subtest bad-create-flags: SUCCESS (0.000s)
[253.101509] [041/133] (773s left) kms_plane (pixel-format-x-tiled-modifier)
[254.613391] Starting subtest: pixel-format-x-tiled-modifier
[254.645238] Starting dynamic subtest: pipe-A-plane-0
[255.728714] Dynamic subtest pipe-A-plane-0: SUCCESS (1.083s)
[255.738155] Starting dynamic subtest: pipe-A-plane-3
[256.429474] Dynamic subtest pipe-A-plane-3: SUCCESS (0.700s)
[256.463448] Starting dynamic subtest: pipe-A-plane-5
[256.465744] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[256.597314] Starting dynamic subtest: pipe-B-plane-0
[257.555869] Dynamic subtest pipe-B-plane-0: SUCCESS (0.967s)
[257.565365] Starting dynamic subtest: pipe-B-plane-3
[258.239211] Dynamic subtest pipe-B-plane-3: SUCCESS (0.683s)
[258.249625] Starting dynamic subtest: pipe-B-plane-5
[258.251833] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[258.296430] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.684s)
[258.571848] [042/133] (768s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[258.653470] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[258.655565] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[258.879754] [043/133] (768s left) gem_eio (in-flight-10ms)
[259.149595] Starting subtest: in-flight-10ms
[264.284421] Subtest in-flight-10ms: SUCCESS (5.135s)
[265.882291] [044/133] (761s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[270.574395] Starting subtest: heavy-verify-multi-ccs
[270.575127] Starting dynamic subtest: lmem0
[278.858464] Dynamic subtest lmem0: SUCCESS (8.286s)
[278.859508] Subtest heavy-verify-multi-ccs: SUCCESS (8.287s)
[279.962508] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[279.963422] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[279.964925] [045/133] (747s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[284.909580] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[284.911216] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[285.103181] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[285.108064] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[285.111605] [046/133] (742s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[286.638062] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[286.639838] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[286.844477] [047/133] (740s left) kms_psr (psr2-primary-render)
[288.363469] Subtest psr2-primary-render: SKIP (0.000s)
[288.422672] [048/133] (738s left) kms_big_fb (x-tiled-addfb-size-overflow)
[289.959184] Starting subtest: x-tiled-addfb-size-overflow
[289.961228] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.002s)
[290.160730] [049/133] (737s left) gem_exec_create (legacy)
[290.264403] Starting subtest: legacy
[290.265254] Starting dynamic subtest: smem
[292.367754] Dynamic subtest smem: SUCCESS (2.103s)
[292.377650] Starting dynamic subtest: lmem0
[294.462958] Dynamic subtest lmem0: SUCCESS (2.094s)
[294.463955] Subtest legacy: SUCCESS (4.199s)
[294.707891] [050/133] (732s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[296.235007] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[296.290641] [051/133] (731s left) kms_async_flips (alternate-sync-async-flip)
[297.809161] Starting subtest: alternate-sync-async-flip
[298.033785] Starting dynamic subtest: pipe-A-HDMI-A-3
[300.319387] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.286s)
[300.519393] Starting dynamic subtest: pipe-B-HDMI-A-3
[302.611210] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.099s)
[302.789791] Starting dynamic subtest: pipe-C-HDMI-A-3
[304.882068] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.099s)
[305.088951] Starting dynamic subtest: pipe-D-HDMI-A-3
[307.173707] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.092s)
[307.174914] Subtest alternate-sync-async-flip: SUCCESS (9.365s)
[307.585888] [052/133] (720s left) gem_pxp (create-protected-buffer)
[310.199262] Starting subtest: create-protected-buffer
[310.201351] Subtest create-protected-buffer: SKIP (0.000s)
[310.310239] [053/133] (717s left) gem_exec_schedule (promotion)
[310.402486] Starting subtest: promotion
[310.403450] Starting dynamic subtest: rcs0
[310.698704] Dynamic subtest rcs0: SUCCESS (0.295s)
[310.707460] Starting dynamic subtest: bcs0
[310.908969] Dynamic subtest bcs0: SUCCESS (0.210s)
[310.917815] Starting dynamic subtest: vcs0
[311.129151] Dynamic subtest vcs0: SUCCESS (0.219s)
[311.137886] Starting dynamic subtest: vcs1
[311.350254] Dynamic subtest vcs1: SUCCESS (0.220s)
[311.358977] Starting dynamic subtest: vecs0
[311.577951] Dynamic subtest vecs0: SUCCESS (0.227s)
[311.586689] Starting dynamic subtest: vecs1
[311.797423] Dynamic subtest vecs1: SUCCESS (0.219s)
[311.806220] Starting dynamic subtest: ccs0
[312.046877] Dynamic subtest ccs0: SUCCESS (0.249s)
[312.047770] Subtest promotion: SUCCESS (1.645s)
[312.460645] [054/133] (715s left) kms_vrr (flip-dpms)
[313.971865] Starting subtest: flip-dpms
[313.974391] Subtest flip-dpms: SKIP (0.000s)
[314.136808] [055/133] (713s left) gem_wait (wait)
[314.259577] Starting subtest: wait
[314.260445] Starting dynamic subtest: all-engines
[315.348354] Dynamic subtest all-engines: SUCCESS (1.088s)
[315.369160] Starting dynamic subtest: rcs0
[316.403636] Dynamic subtest rcs0: SUCCESS (1.053s)
[316.418073] Starting dynamic subtest: bcs0
[317.459716] Dynamic subtest bcs0: SUCCESS (1.053s)
[317.474146] Starting dynamic subtest: vcs0
[318.515587] Dynamic subtest vcs0: SUCCESS (1.052s)
[318.530152] Starting dynamic subtest: vcs1
[319.573445] Dynamic subtest vcs1: SUCCESS (1.054s)
[319.587958] Starting dynamic subtest: vecs0
[320.632669] Dynamic subtest vecs0: SUCCESS (1.056s)
[320.647187] Starting dynamic subtest: vecs1
[321.689523] Dynamic subtest vecs1: SUCCESS (1.053s)
[321.703864] Starting dynamic subtest: ccs0
[322.746564] Dynamic subtest ccs0: SUCCESS (1.053s)
[322.751749] Subtest wait: SUCCESS (8.488s)
[323.030488] [056/133] (704s left) prime_mmap_kms (buffer-sharing)
[324.546520] Starting subtest: buffer-sharing
[324.890921] Subtest buffer-sharing: SUCCESS (0.343s)
[325.163672] [057/133] (702s left) gem_ctx_persistence (hang)
[325.278211] Starting subtest: hang
[325.280138] Subtest hang: SKIP (0.000s)
[325.438800] [058/133] (702s left) gem_softpin (allocator-basic)
[325.522816] Starting subtest: allocator-basic
[325.744236] Subtest allocator-basic: SUCCESS (0.221s)
[325.911545] [059/133] (702s left) kms_plane_multiple (2x-tiling-4)
[327.423172] Starting subtest: 2x-tiling-4
[327.424929] Subtest 2x-tiling-4: SKIP (0.000s)
[327.569591] [060/133] (700s left) gem_render_copy (linear)
[327.681596] Starting subtest: linear
[327.682513] Starting dynamic subtest: smem
[327.788912] Dynamic subtest smem: SUCCESS (0.107s)
[327.797730] Starting dynamic subtest: lmem0
[328.044658] Dynamic subtest lmem0: SUCCESS (0.255s)
[328.045651] Subtest linear: SUCCESS (0.363s)
[328.339488] [061/133] (699s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[329.863154] Starting subtest: 4-tiled-8bpp-rotate-90
[329.929063] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.064s)
[330.164174] [062/133] (698s left) kms_atomic (plane-primary-legacy)
[331.678041] Starting subtest: plane-primary-legacy
[331.678974] Starting dynamic subtest: pipe-A-HDMI-A-3
[332.602435] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.924s)
[332.603415] Subtest plane-primary-legacy: SUCCESS (0.926s)
[332.842094] [063/133] (695s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[334.360992] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[334.362667] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[334.588273] [064/133] (693s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[336.108063] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[336.109828] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[336.320343] [065/133] (692s left) i915_suspend (debugfs-reader)
[336.416225] Starting subtest: debugfs-reader
[357.935464] Subtest debugfs-reader: SUCCESS (5.777s)
[367.211651] [066/133] (670s left) kms_getfb (getfb-reject-nv12)
[368.769533] Starting subtest: getfb-reject-nv12
[368.771675] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[368.983707] [067/133] (669s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[369.073710] Starting subtest: single-wait-for-submit-unsubmitted
[369.178095] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[369.361923] [068/133] (668s left) kms_draw_crc (draw-method-mmap-wc)
[370.916190] Starting subtest: draw-method-mmap-wc
[370.917897] Subtest draw-method-mmap-wc: SKIP (0.000s)
[371.133878] [069/133] (667s left) gem_exec_whisper (basic-forked)
[371.226212] Starting subtest: basic-forked
[376.075911] Subtest basic-forked: SUCCESS (4.770s)
[376.368138] [070/133] (661s left) kms_invalid_mode (bad-hsync-start)
[377.898472] Starting subtest: bad-hsync-start
[377.899388] Starting dynamic subtest: pipe-A-HDMI-A-3
[377.954182] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.053s)
[377.965014] Starting dynamic subtest: pipe-B-HDMI-A-3
[377.966128] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s)
[377.976456] Starting dynamic subtest: pipe-C-HDMI-A-3
[377.977366] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s)
[377.988010] Starting dynamic subtest: pipe-D-HDMI-A-3
[377.989113] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s)
[377.990330] Subtest bad-hsync-start: SUCCESS (0.062s)
[378.202900] [071/133] (660s left) gem_exec_schedule (pi-shared-iova)
[378.406364] Starting subtest: pi-shared-iova
[378.407298] Starting dynamic subtest: rcs0
[378.669361] Dynamic subtest rcs0: SUCCESS (0.260s)
[378.680058] Starting dynamic subtest: bcs0
[378.845313] Dynamic subtest bcs0: SUCCESS (0.174s)
[378.856250] Starting dynamic subtest: vcs0
[379.034234] Dynamic subtest vcs0: SUCCESS (0.186s)
[379.045039] Starting dynamic subtest: vcs1
[379.228485] Dynamic subtest vcs1: SUCCESS (0.192s)
[379.239466] Starting dynamic subtest: vecs0
[379.419669] Dynamic subtest vecs0: SUCCESS (0.189s)
[379.430503] Starting dynamic subtest: vecs1
[379.615021] Dynamic subtest vecs1: SUCCESS (0.193s)
[379.626843] Starting dynamic subtest: ccs0
[379.819634] Dynamic subtest ccs0: SUCCESS (0.202s)
[379.820565] Subtest pi-shared-iova: SUCCESS (1.403s)
[380.194522] [072/133] (658s left) drm_read (empty-block)
[381.796951] Starting subtest: empty-block
[382.798988] Subtest empty-block: SUCCESS (0.995s)
[383.032772] [073/133] (655s left) syncobj_timeline (invalid-transfer-bad-pad)
[383.108621] Starting subtest: invalid-transfer-bad-pad
[383.109496] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[383.280934] [074/133] (655s left) gem_ctx_param (invalid-ctx-get)
[383.369027] Starting subtest: invalid-ctx-get
[383.369957] Subtest invalid-ctx-get: SUCCESS (0.000s)
[383.536652] [075/133] (655s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[385.067468] Starting subtest: y-tiled-16bpp-rotate-90
[385.069463] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[385.282715] [076/133] (653s left) gen9_exec_parse (bb-start-param)
[385.373389] Subtest bb-start-param: SKIP (0.000s)
[385.465770] [077/133] (653s left) gem_exec_params (cliprects_ptr-dirt)
[385.552169] Starting subtest: cliprects_ptr-dirt
[385.553192] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[385.721989] [078/133] (653s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[387.250339] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[387.252076] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[387.422803] [079/133] (651s left) kms_big_fb (linear-64bpp-rotate-180)
[388.968584] Starting subtest: linear-64bpp-rotate-180
[391.130030] Subtest linear-64bpp-rotate-180: SUCCESS (2.156s)
[391.327088] [080/133] (647s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[392.892552] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[392.999831] [081/133] (646s left) gem_create (create-valid-nonaligned)
[393.086506] Starting subtest: create-valid-nonaligned
[393.087403] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[393.371985] [082/133] (645s left) gem_exec_balancer (fairslice)
[393.458758] Starting subtest: fairslice
[399.000794] Subtest fairslice: SUCCESS (5.536s)
[399.417128] [083/133] (639s left) kms_psr (pr-cursor-plane-move)
[400.930578] Subtest pr-cursor-plane-move: SKIP (0.000s)
[401.005371] [084/133] (638s left) perf_pmu (multi-client)
[401.081570] Starting subtest: multi-client
[401.082528] Starting dynamic subtest: rcs0
[402.178943] Dynamic subtest rcs0: SUCCESS (1.096s)
[402.193788] Starting dynamic subtest: bcs0
[403.232699] Dynamic subtest bcs0: SUCCESS (1.050s)
[403.247387] Starting dynamic subtest: vcs0
[404.286909] Dynamic subtest vcs0: SUCCESS (1.050s)
[404.302016] Starting dynamic subtest: vcs1
[405.341554] Dynamic subtest vcs1: SUCCESS (1.050s)
[405.356130] Starting dynamic subtest: vecs0
[406.396479] Dynamic subtest vecs0: SUCCESS (1.051s)
[406.411197] Starting dynamic subtest: vecs1
[407.451298] Dynamic subtest vecs1: SUCCESS (1.051s)
[407.466138] Starting dynamic subtest: ccs0
[408.507548] Dynamic subtest ccs0: SUCCESS (1.052s)
[408.511860] Subtest multi-client: SUCCESS (7.427s)
[408.718861] [085/133] (630s left) kms_cursor_legacy (forked-bo)
[410.233168] Starting subtest: forked-bo
[410.234146] Starting dynamic subtest: pipe-A
[415.672471] Dynamic subtest pipe-A: SUCCESS (5.437s)
[415.692752] Starting dynamic subtest: pipe-B
[421.109793] Dynamic subtest pipe-B: SUCCESS (5.434s)
[421.136498] Starting dynamic subtest: pipe-C
[426.546966] Dynamic subtest pipe-C: SUCCESS (5.433s)
[426.575089] Starting dynamic subtest: pipe-D
[431.995000] Dynamic subtest pipe-D: SUCCESS (5.437s)
[432.018738] Starting dynamic subtest: all-pipes
[437.413373] Dynamic subtest all-pipes: SUCCESS (5.422s)
[437.414291] Subtest forked-bo: SUCCESS (27.172s)
[437.599197] [086/133] (601s left) sysfs_timeslice_duration (idempotent)
[437.682051] Starting subtest: idempotent
[437.682966] Starting dynamic subtest: vecs0
[437.683787] Dynamic subtest vecs0: SUCCESS (0.001s)
[437.695758] Starting dynamic subtest: ccs0
[437.696828] Dynamic subtest ccs0: SUCCESS (0.000s)
[437.708306] Starting dynamic subtest: vcs0
[437.709406] Dynamic subtest vcs0: SUCCESS (0.001s)
[437.720569] Starting dynamic subtest: bcs0
[437.721661] Dynamic subtest bcs0: SUCCESS (0.000s)
[437.732984] Starting dynamic subtest: vecs1
[437.734085] Dynamic subtest vecs1: SUCCESS (0.001s)
[437.745354] Starting dynamic subtest: rcs0
[437.746576] Dynamic subtest rcs0: SUCCESS (0.000s)
[437.757864] Starting dynamic subtest: vcs1
[437.758973] Dynamic subtest vcs1: SUCCESS (0.001s)
[437.760074] Subtest idempotent: SUCCESS (0.011s)
[437.827471] [087/133] (601s left) gem_mmap (bad-object)
[437.911409] Subtest bad-object: SKIP (0.000s)
[437.973565] [088/133] (601s left) syncobj_timeline (multi-wait-signaled)
[438.056547] Starting subtest: multi-wait-signaled
[438.057589] Subtest multi-wait-signaled: SUCCESS (0.001s)
[438.235198] [089/133] (601s left) gem_userptr_blits (map-fixed-invalidate)
[438.327224] Starting subtest: map-fixed-invalidate
[438.329026] Subtest map-fixed-invalidate: SKIP (0.000s)
[438.517073] [090/133] (601s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[440.037234] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[440.038955] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[440.272922] [091/133] (599s left) kms_pm_dc (dc6-psr)
[442.793130] Starting subtest: dc6-psr
[442.794813] Subtest dc6-psr: SKIP (0.000s)
[442.952297] [092/133] (597s left) kms_chamelium_frames (dp-crc-fast)
[444.541927] Subtest dp-crc-fast: SKIP (0.000s)
[444.644914] [093/133] (595s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[446.167127] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[446.168734] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[446.381120] [094/133] (593s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[447.903904] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[447.905515] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[448.120051] [095/133] (592s left) gem_mmap_gtt (medium-copy)
[448.197395] Subtest medium-copy: SKIP (0.000s)
[448.276968] [096/133] (592s left) gem_mmap_wc (read-write-distinct)
[448.370424] Subtest read-write-distinct: SKIP (0.000s)
[448.496598] [097/133] (591s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[450.019378] Starting subtest: psr-2p-primscrn-spr-indfb-move
[450.021151] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[450.225272] [098/133] (590s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[451.745194] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[484.907783] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (33.162s)
[485.160094] [099/133] (555s left) kms_selftest (drm_format)
[485.209600] Starting subtest: drm_format
[485.250298] Starting dynamic subtest: drm_test_format_block_width_invalid
[485.324814] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.075s)
[485.354407] Starting dynamic subtest: drm_test_format_block_width_one_plane
[485.404064] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.078s)
[485.444861] Starting dynamic subtest: drm_test_format_block_width_two_plane
[485.493225] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.084s)
[485.528093] Starting dynamic subtest: drm_test_format_block_width_three_plane
[485.572621] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.077s)
[485.607416] Starting dynamic subtest: drm_test_format_block_width_tiled
[485.693781] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.119s)
[485.732409] Starting dynamic subtest: drm_test_format_block_height_invalid
[485.784798] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.079s)
[485.822980] Starting dynamic subtest: drm_test_format_block_height_one_plane
[485.863598] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.084s)
[485.878948] Starting dynamic subtest: drm_test_format_block_height_two_plane
[485.942480] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.076s)
[485.984136] Starting dynamic subtest: drm_test_format_block_height_three_plane
[486.030069] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.086s)
[486.069243] Starting dynamic subtest: drm_test_format_block_height_tiled
[486.123695] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.090s)
[486.160708] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[486.208756] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.083s)
[486.251586] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[486.297775] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.084s)
[486.337283] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[486.372426] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.073s)
[486.404823] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[486.458577] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.083s)
[486.499840] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[486.531869] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.071s)
[486.549461] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[486.607590] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.073s)
[486.649158] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[486.698137] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.086s)
[486.733132] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[486.775452] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.075s)
[486.776497] Subtest drm_format: SUCCESS (1.566s)
[487.009800] [100/133] (553s left) gem_exec_suspend (basic)
[487.101812] Starting subtest: basic
[487.102731] Starting dynamic subtest: smem
[488.336524] Dynamic subtest smem: SUCCESS (1.234s)
[488.348355] Starting dynamic subtest: lmem0
[489.487339] Dynamic subtest lmem0: SUCCESS (1.150s)
[489.488257] Subtest basic: SUCCESS (2.386s)
[489.821534] [101/133] (550s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[491.344110] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[491.345759] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[491.575042] [102/133] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[493.094292] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[493.096024] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[493.320907] [103/133] (547s left) gem_ctx_shared (exec-single-timeline)
[493.407869] Starting subtest: exec-single-timeline
[493.408808] Starting dynamic subtest: rcs0
[494.483151] Dynamic subtest rcs0: SUCCESS (1.074s)
[494.498352] Starting dynamic subtest: bcs0
[495.507281] Dynamic subtest bcs0: SUCCESS (1.020s)
[495.522625] Starting dynamic subtest: vcs0
[496.531391] Dynamic subtest vcs0: SUCCESS (1.019s)
[496.546657] Starting dynamic subtest: vcs1
[497.555275] Dynamic subtest vcs1: SUCCESS (1.019s)
[497.570871] Starting dynamic subtest: vecs0
[498.579324] Dynamic subtest vecs0: SUCCESS (1.019s)
[498.594739] Starting dynamic subtest: vecs1
[499.603299] Dynamic subtest vecs1: SUCCESS (1.019s)
[499.618629] Starting dynamic subtest: ccs0
[500.626782] Dynamic subtest ccs0: SUCCESS (1.019s)
[500.628445] Subtest exec-single-timeline: SUCCESS (7.219s)
[500.916275] [104/133] (540s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[502.427368] Starting subtest: primary-yf-tiled-reflect-x-0
[502.531565] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.104s)
[502.747152] [105/133] (538s left) gem_softpin (invalid)
[502.852538] Starting subtest: invalid
[502.864595] Subtest invalid: SUCCESS (0.012s)
[503.023301] [106/133] (538s left) kms_flip (2x-flip-vs-dpms-on-nop)
[504.538118] Starting subtest: 2x-flip-vs-dpms-on-nop
[504.550396] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.013s)
[504.717348] [107/133] (536s left) kms_psr (fbc-pr-cursor-blt)
[506.258743] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[506.326243] [108/133] (535s left) api_intel_bb (delta-check)
[506.404087] Starting subtest: delta-check
[506.434590] Subtest delta-check: SUCCESS (0.031s)
[506.655111] [109/133] (534s left) prime_mmap_coherency (read)
[506.734207] Starting subtest: read
[512.146305] Subtest read: SUCCESS (5.411s)
[512.337680] [110/133] (529s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[514.148421] Starting subtest: cursor-rapid-movement-512x170
[514.150253] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[514.392816] [111/133] (527s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[515.905344] Starting subtest: cursorB-vs-flipA-atomic
[515.907102] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s)
[516.088670] [112/133] (525s left) kms_plane (plane-panning-bottom-right-suspend)
[517.611396] Starting subtest: plane-panning-bottom-right-suspend
[517.612285] Starting dynamic subtest: pipe-A
[537.091658] Dynamic subtest pipe-A: SUCCESS (4.411s)
[537.105198] Starting dynamic subtest: pipe-B
[557.041349] Dynamic subtest pipe-B: SUCCESS (3.787s)
[557.042162] Subtest plane-panning-bottom-right-suspend: SUCCESS (8.202s)
[565.260206] [113/133] (484s left) kms_plane_alpha_blend (constant-alpha-max)
[566.882382] Starting subtest: constant-alpha-max
[567.131159] Starting dynamic subtest: pipe-A-HDMI-A-3
[568.027901] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.873s)
[568.044172] Starting dynamic subtest: pipe-D-HDMI-A-3
[568.928261] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.877s)
[568.929618] Subtest constant-alpha-max: SUCCESS (1.996s)
[569.145171] [114/133] (480s left) kms_content_protection (type1)
[570.748397] Starting subtest: type1
[570.756725] Subtest type1: SKIP (0.006s)
[570.968650] [115/133] (479s left) syncobj_eventfd (binary-wait)
[571.048571] Starting subtest: binary-wait
[571.059314] Subtest binary-wait: SUCCESS (0.011s)
[571.207988] [116/133] (478s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[572.750038] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[572.751786] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[572.992404] [117/133] (477s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[574.525515] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[574.593163] [118/133] (475s left) fbdev (info)
[574.640565] Starting subtest: info
[574.641497] Subtest info: SUCCESS (0.000s)
[574.757143] [119/133] (475s left) kms_cursor_crc (cursor-suspend)
[576.354512] Starting subtest: cursor-suspend
[576.356883] Starting dynamic subtest: pipe-A-HDMI-A-3
[615.126155] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (7.833s)
[615.139848] Starting dynamic subtest: pipe-D-HDMI-A-3
[654.192902] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (7.497s)
[654.193925] Subtest cursor-suspend: SUCCESS (15.334s)
[665.728464] [120/133] (395s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[667.292031] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[667.293874] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[667.547245] [121/133] (394s left) i915_pm_freq_api (freq-basic-api)
[667.633475] Starting subtest: freq-basic-api
[667.634344] Starting dynamic subtest: gt0
[667.638127] Dynamic subtest gt0: SUCCESS (0.004s)
[667.639017] Subtest freq-basic-api: SUCCESS (0.005s)
[667.820598] [122/133] (393s left) kms_prop_blob (invalid-get-prop)
[667.906498] Starting subtest: invalid-get-prop
[667.907491] Subtest invalid-get-prop: SUCCESS (0.000s)
[668.097755] [123/133] (393s left) gem_exec_params (rsvd2-dirt)
[668.179787] Starting subtest: rsvd2-dirt
[668.181649] Subtest rsvd2-dirt: SKIP (0.000s)
[668.330776] [124/133] (393s left) i915_pm_rc6_residency (rc6-idle)
[668.410458] Starting subtest: rc6-idle
[668.430553] Starting dynamic subtest: gt0-rcs0
[693.007192] Dynamic subtest gt0-rcs0: SUCCESS (24.409s)
[693.023449] Starting dynamic subtest: gt0-bcs0
[717.423374] Dynamic subtest gt0-bcs0: SUCCESS (24.404s)
[717.438867] Starting dynamic subtest: gt0-vcs0
[741.751511] Dynamic subtest gt0-vcs0: SUCCESS (24.317s)
[741.766827] Starting dynamic subtest: gt0-vecs0
[765.987804] Dynamic subtest gt0-vecs0: SUCCESS (24.226s)
[766.003443] Starting dynamic subtest: gt0-ccs0
[790.398768] Dynamic subtest gt0-ccs0: SUCCESS (24.411s)
[790.404657] Subtest rc6-idle: SUCCESS (121.804s)
[790.549467] [125/133] (271s left) perf (non-zero-reason)
[791.000109] Starting subtest: non-zero-reason
[791.000989] Starting dynamic subtest: 0-rcs0
[794.051884] Dynamic subtest 0-rcs0: FAIL (2.754s)
[794.053377] Subtest non-zero-reason: FAIL (2.755s)
[794.128067] [126/133] (267s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[795.661444] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[795.663102] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[795.898482] [127/133] (266s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[797.419969] Starting subtest: x-tiled-16bpp-rotate-180
[799.249958] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.829s)
[799.464565] [128/133] (262s left) kms_chamelium_color (ctm-0-50)
[800.978954] Subtest ctm-0-50: SKIP (0.000s)
[801.044913] [129/133] (261s left) kms_cursor_crc (cursor-onscreen-32x10)
[802.681037] Starting subtest: cursor-onscreen-32x10
[802.735142] Subtest cursor-onscreen-32x10: SKIP (0.052s)
[803.299217] [130/133] (259s left) sw_sync (sync_busy_fork)
[803.384112] Starting subtest: sync_busy_fork
[804.399734] Subtest sync_busy_fork: SUCCESS (1.015s)
[804.499700] [131/133] (257s left) syncobj_eventfd (invalid-illegal-eventfd)
[804.574899] Starting subtest: invalid-illegal-eventfd
[804.575870] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[804.725206] [132/133] (257s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[806.238842] Starting subtest: 2x-long-cursor-vs-flip-atomic
[806.241915] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[806.416080] [133/133] (256s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[807.960607] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[807.962461] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[808.155207] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_offset
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_color
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: prime_mmap
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gem_caching
results: parsing output: 13/ for test: api_intel_allocator
results: parsing output: 14/ for test: gem_tiled_swapping
results: parsing output: 15/ for test: kms_lease
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_atomic_interruptible
results: parsing output: 18/ for test: gem_partial_pwrite_pread
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: gem_create
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_pm_rpm
results: parsing output: 24/ for test: gem_tiled_pread_pwrite
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: prime_self_import
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_flip_scaled_crc
results: parsing output: 30/ for test: kms_pm_backlight
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: gem_exec_params
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: device_reset
results: parsing output: 36/ for test: gem_ctx_exec
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: syncobj_basic
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_exec_create
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_vrr
results: parsing output: 54/ for test: gem_wait
results: parsing output: 55/ for test: prime_mmap_kms
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: gem_softpin
results: parsing output: 58/ for test: kms_plane_multiple
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_atomic
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: i915_suspend
results: parsing output: 65/ for test: kms_getfb
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: kms_draw_crc
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: kms_invalid_mode
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: drm_read
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_ctx_param
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gen9_exec_parse
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_chamelium_hpd
results: parsing output: 80/ for test: gem_create
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: sysfs_timeslice_duration
results: parsing output: 86/ for test: gem_mmap
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_pm_dc
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: gem_mmap_wc
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_selftest
results: parsing output: 99/ for test: gem_exec_suspend
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_ctx_shared
results: parsing output: 103/ for test: kms_rotation_crc
results: parsing output: 104/ for test: gem_softpin
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: prime_mmap_coherency
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_plane_alpha_blend
results: parsing output: 113/ for test: kms_content_protection
results: parsing output: 114/ for test: syncobj_eventfd
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: fbdev
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: i915_pm_freq_api
results: parsing output: 121/ for test: kms_prop_blob
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: i915_pm_rc6_residency
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_chamelium_color
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: sw_sync
results: parsing output: 130/ for test: syncobj_eventfd
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.