[184.149627] Initializing watchdogs
[184.149693]   /dev/watchdog0
[184.170570] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[184.182182] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[184.186191] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[184.188619] [001/156] (960s left) kms_atomic (crtc-invalid-params)
[184.383534] Starting subtest: crtc-invalid-params
[184.384453] Starting dynamic subtest: pipe-A-DP-3
[184.928365] Dynamic subtest pipe-A-DP-3: SUCCESS (0.545s)
[184.929287] Subtest crtc-invalid-params: SUCCESS (0.547s)
[185.260017] [002/156] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[185.444588] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[185.446336] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[185.639964] [003/156] (959s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[185.823735] Starting subtest: addfb25-y-tiled-legacy
[185.824606] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[185.961390] [004/156] (958s left) kms_addfb_basic (size-max)
[186.142382] Starting subtest: size-max
[186.143281] Subtest size-max: SUCCESS (0.000s)
[186.278507] [005/156] (958s left) core_auth (getclient-master-drop)
[186.322747] Starting subtest: getclient-master-drop
[186.360487] Subtest getclient-master-drop: SUCCESS (0.038s)
[186.491766] [006/156] (958s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[186.564313] Starting subtest: single-wait-for-submit-available-signaled
[186.565242] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[186.752136] [007/156] (958s left) kms_hdmi_inject (inject-4k)
[186.917257] Starting subtest: inject-4k
[187.129628] Subtest inject-4k: SUCCESS (0.213s)
[187.486699] [008/156] (957s left) kms_psr (fbc-pr-primary-page-flip)
[187.670906] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[187.718163] [009/156] (957s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[187.904692] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[187.906328] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[188.037377] [010/156] (957s left) gem_exec_whisper (basic-sync-all)
[188.126242] Starting subtest: basic-sync-all
[193.325699] Subtest basic-sync-all: SUCCESS (5.199s)
[193.582714] [011/156] (951s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[193.659552] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[193.661593] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[193.903463] [012/156] (951s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[194.175026] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[194.362535] [013/156] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[194.550939] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[197.378793] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.829s)
[197.561552] [014/156] (947s left) kms_content_protection (atomic)
[197.809993] Starting subtest: atomic
[197.844068] Starting dynamic subtest: pipe-A-DP-3
[321.105727] Dynamic subtest pipe-A-DP-3: FAIL (123.090s)
[321.107043] Subtest atomic: FAIL (123.229s)
[321.348610] [015/156] (824s left) testdisplay
[340.893209] [016/156] (804s left) drm_read (empty-block)
[341.140536] Starting subtest: empty-block
[342.142236] Subtest empty-block: SUCCESS (1.000s)
[342.308946] [017/156] (803s left) gem_exec_params (dr1-dirt)
[342.386043] Starting subtest: DR1-dirt
[342.386946] Subtest DR1-dirt: SUCCESS (0.000s)
[342.528277] [018/156] (803s left) kms_flip (flip-vs-expired-vblank-interruptible)
[342.712695] Starting subtest: flip-vs-expired-vblank-interruptible
[342.717283] Starting dynamic subtest: A-DP3
[350.533064] Dynamic subtest A-DP3: SUCCESS (7.815s)
[350.546060] Starting dynamic subtest: B-DP3
[358.304687] Dynamic subtest B-DP3: SUCCESS (7.769s)
[358.317958] Starting dynamic subtest: C-DP3
[366.080792] Dynamic subtest C-DP3: SUCCESS (7.772s)
[366.106920] Starting dynamic subtest: D-DP3
[373.864756] Dynamic subtest D-DP3: SUCCESS (7.779s)
[373.869613] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (31.157s)
[374.228113] [019/156] (771s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[374.415641] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[374.417332] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[374.547411] [020/156] (771s left) kms_pm_rpm (modeset-pc8-residency-stress)
[376.051862] Starting subtest: modeset-pc8-residency-stress
[376.055762] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[376.542367] [021/156] (769s left) kms_fb_coherency (memset-crc)
[376.725066] Starting subtest: memset-crc
[376.726014] Starting dynamic subtest: mmap-offset-fixed
[377.257735] Dynamic subtest mmap-offset-fixed: SUCCESS (0.532s)
[377.356738] Subtest memset-crc: SUCCESS (0.632s)
[377.679513] [022/156] (768s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[377.860577] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[377.889743] Starting dynamic subtest: pipe-A-plane-0
[378.556311] Dynamic subtest pipe-A-plane-0: SUCCESS (0.666s)
[378.566800] Starting dynamic subtest: pipe-A-plane-3
[379.057151] Dynamic subtest pipe-A-plane-3: SUCCESS (0.500s)
[379.317217] Starting dynamic subtest: pipe-B-plane-0
[379.823829] Dynamic subtest pipe-B-plane-0: SUCCESS (0.533s)
[379.836449] Starting dynamic subtest: pipe-B-plane-3
[380.290495] Dynamic subtest pipe-B-plane-3: SUCCESS (0.466s)
[380.366494] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.505s)
[380.665785] [023/156] (765s left) gem_mmap_offset (clear)
[380.740346] Starting subtest: clear
[380.741327] Starting dynamic subtest: lmem0
[408.512636] Dynamic subtest lmem0: SUCCESS (27.759s)
[408.531621] Starting dynamic subtest: smem0
[431.888664] Dynamic subtest smem0: SUCCESS (23.388s)
[431.889724] Subtest clear: SUCCESS (51.148s)
[432.098200] [024/156] (714s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[432.323370] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[432.324184] Starting dynamic subtest: pipe-A
[432.429983] Dynamic subtest pipe-A: SUCCESS (0.106s)
[432.449570] Starting dynamic subtest: pipe-B
[432.659692] Dynamic subtest pipe-B: SUCCESS (0.229s)
[432.679061] Starting dynamic subtest: pipe-C
[432.906256] Dynamic subtest pipe-C: SUCCESS (0.246s)
[432.916648] Starting dynamic subtest: pipe-D
[433.119674] Dynamic subtest pipe-D: SUCCESS (0.213s)
[433.120714] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.797s)
[433.497953] [025/156] (712s left) kms_psr (psr-cursor-mmap-cpu)
[433.682358] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[433.742112] [026/156] (712s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-plflip-blt)
[433.932859] Starting subtest: psrhdr-2p-primscrn-shrfb-plflip-blt
[433.934535] Subtest psrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[434.073130] [027/156] (712s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[434.271638] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[434.273430] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[434.402691] [028/156] (712s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite)
[434.588015] Starting subtest: fbchdr-rgb101010-draw-pwrite
[435.054750] Subtest fbchdr-rgb101010-draw-pwrite: SUCCESS (0.468s)
[435.282642] [029/156] (711s left) syncobj_basic (create-signaled)
[435.354192] Starting subtest: create-signaled
[435.355143] Subtest create-signaled: SUCCESS (0.000s)
[435.470690] [030/156] (711s left) i915_pm_rc6_residency (rc6-fence)
[435.541232] Starting subtest: rc6-fence
[435.550152] Starting dynamic subtest: gt0
[460.076670] Dynamic subtest gt0: SUCCESS (24.527s)
[460.077700] Subtest rc6-fence: SUCCESS (24.537s)
[460.202167] [031/156] (686s left) gem_exec_schedule (pi-common)
[460.406035] Starting subtest: pi-common
[460.407011] Starting dynamic subtest: rcs0
[460.493485] Dynamic subtest rcs0: SUCCESS (0.087s)
[460.505179] Starting dynamic subtest: bcs0
[460.522423] Dynamic subtest bcs0: SUCCESS (0.028s)
[460.534198] Starting dynamic subtest: vcs0
[460.551280] Dynamic subtest vcs0: SUCCESS (0.028s)
[460.562924] Starting dynamic subtest: vcs1
[460.579757] Dynamic subtest vcs1: SUCCESS (0.028s)
[460.591673] Starting dynamic subtest: vecs0
[460.608905] Dynamic subtest vecs0: SUCCESS (0.028s)
[460.620545] Starting dynamic subtest: vecs1
[460.638202] Dynamic subtest vecs1: SUCCESS (0.029s)
[460.649827] Starting dynamic subtest: ccs0
[460.668195] Dynamic subtest ccs0: SUCCESS (0.029s)
[460.669137] Subtest pi-common: SUCCESS (0.263s)
[460.937558] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[460.939461] [032/156] (685s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[461.135791] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[461.137453] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[461.317452] [033/156] (685s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[461.509073] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[461.509975] Starting dynamic subtest: pipe-A-DP-3
[480.828628] Dynamic subtest pipe-A-DP-3: SUCCESS (4.214s)
[480.873643] Starting dynamic subtest: pipe-B-DP-3
[500.789008] Dynamic subtest pipe-B-DP-3: SUCCESS (3.881s)
[500.812674] Starting dynamic subtest: pipe-C-DP-3
[520.848457] Dynamic subtest pipe-C-DP-3: SUCCESS (3.905s)
[520.883923] Starting dynamic subtest: pipe-D-DP-3
[540.821535] Dynamic subtest pipe-D-DP-3: SUCCESS (3.836s)
[540.822691] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SUCCESS (15.845s)
[559.225788] [034/156] (605s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[559.305831] Starting subtest: multi-wait-all-for-submit-signaled
[559.306758] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[559.460248] [035/156] (605s left) kms_frontbuffer_tracking (psrhdr-1p-pri-indfb-multidraw)
[559.655331] Starting subtest: psrhdr-1p-pri-indfb-multidraw
[559.657174] Subtest psrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[559.800560] [036/156] (605s left) kms_pm_rpm (drm-resources-equal)
[561.351913] Starting subtest: drm-resources-equal
[562.734996] Subtest drm-resources-equal: SUCCESS (1.370s)
[562.904171] [037/156] (602s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[563.106601] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[563.107574] Starting dynamic subtest: pipe-A-valid-mode
[565.062639] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.936s)
[565.064850] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SUCCESS (1.939s)
[565.348674] [038/156] (599s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[565.545594] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[565.547331] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[565.677259] [039/156] (599s left) vgem_basic (bad-fence)
[565.740210] Starting subtest: bad-fence
[565.741030] Subtest bad-fence: SUCCESS (0.000s)
[565.829947] [040/156] (599s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[566.030815] Starting subtest: y-tiled-16bpp-rotate-180
[566.032664] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[566.153969] [041/156] (599s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[566.350583] Starting subtest: psr-dirtyfb-ioctl
[566.355801] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[566.488995] [042/156] (599s left) api_intel_allocator (gem-pool)
[566.570896] Starting subtest: gem-pool
[566.604866] Subtest gem-pool: SUCCESS (0.035s)
[566.807813] [043/156] (598s left) kms_big_fb (linear-64bpp-rotate-180)
[567.010828] Starting subtest: linear-64bpp-rotate-180
[569.145922] Subtest linear-64bpp-rotate-180: SUCCESS (2.122s)
[569.339626] [044/156] (596s left) gem_exec_schedule (fifo)
[569.434898] Starting subtest: fifo
[569.435858] Starting dynamic subtest: rcs0
[569.720156] Dynamic subtest rcs0: SUCCESS (0.283s)
[569.733801] Starting dynamic subtest: bcs0
[569.922082] Dynamic subtest bcs0: SUCCESS (0.200s)
[569.935747] Starting dynamic subtest: vcs0
[570.134652] Dynamic subtest vcs0: SUCCESS (0.210s)
[570.148430] Starting dynamic subtest: vcs1
[570.347202] Dynamic subtest vcs1: SUCCESS (0.211s)
[570.361001] Starting dynamic subtest: vecs0
[570.560642] Dynamic subtest vecs0: SUCCESS (0.211s)
[570.574129] Starting dynamic subtest: vecs1
[570.771959] Dynamic subtest vecs1: SUCCESS (0.210s)
[570.785808] Starting dynamic subtest: ccs0
[570.981801] Dynamic subtest ccs0: SUCCESS (0.208s)
[570.982893] Subtest fifo: SUCCESS (1.540s)
[571.502627] [045/156] (594s left) gem_softpin (overlap)
[571.589817] Starting subtest: overlap
[574.626164] Subtest overlap: SUCCESS (3.026s)
[574.778799] [046/156] (591s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt)
[574.974447] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt
[575.833376] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SUCCESS (0.856s)
[576.079753] [047/156] (589s left) i915_drm_fdinfo (memory-info-idle)
[576.154778] Starting subtest: memory-info-idle
[576.155698] Starting dynamic subtest: lmem0
[576.234792] Dynamic subtest lmem0: SUCCESS (0.080s)
[576.250705] Starting dynamic subtest: smem0
[576.277789] Dynamic subtest smem0: SUCCESS (0.042s)
[576.278796] Subtest memory-info-idle: SUCCESS (0.124s)
[576.390193] [048/156] (589s left) syncobj_timeline (invalid-transfer-bad-pad)
[576.470744] Starting subtest: invalid-transfer-bad-pad
[576.471723] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[576.640982] [049/156] (589s left) i915_hangman (gt-engine-hang)
[576.740374] Starting subtest: gt-engine-hang
[576.741346] Starting dynamic subtest: rcs0
[577.533800] Dynamic subtest rcs0: SUCCESS (0.791s)
[577.548192] Starting dynamic subtest: bcs0
[578.248814] Dynamic subtest bcs0: SUCCESS (0.713s)
[578.262927] Starting dynamic subtest: vcs0
[578.960767] Dynamic subtest vcs0: SUCCESS (0.710s)
[578.975128] Starting dynamic subtest: vcs1
[579.706821] Dynamic subtest vcs1: SUCCESS (0.744s)
[579.720820] Starting dynamic subtest: vecs0
[580.416753] Dynamic subtest vecs0: SUCCESS (0.708s)
[580.430596] Starting dynamic subtest: vecs1
[581.134771] Dynamic subtest vecs1: SUCCESS (0.716s)
[581.149052] Starting dynamic subtest: ccs0
[581.882953] Dynamic subtest ccs0: SUCCESS (0.746s)
[581.883871] Subtest gt-engine-hang: SUCCESS (5.135s)
[582.052670] [050/156] (584s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[582.246562] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[582.248283] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[582.398670] [051/156] (583s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[582.587835] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[582.588730] Starting dynamic subtest: pipe-A-DP-3
[582.597460] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[582.610996] Starting dynamic subtest: pipe-B-DP-3
[582.619450] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[582.632743] Starting dynamic subtest: pipe-C-DP-3
[582.641212] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[582.654766] Starting dynamic subtest: pipe-D-DP-3
[582.665948] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[582.667954] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[583.087906] [052/156] (583s left) kms_psr (fbc-psr-sprite-render)
[583.277576] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[583.343169] [053/156] (583s left) gem_pread (display)
[583.427390] Subtest display: SKIP (0.000s)
[583.492781] [054/156] (582s left) kms_flip (blocking-wf_vblank)
[583.687708] Starting subtest: blocking-wf_vblank
[583.692328] Starting dynamic subtest: A-DP3
[591.848627] Dynamic subtest A-DP3: SUCCESS (8.153s)
[591.865076] Starting dynamic subtest: B-DP3
[599.923563] Dynamic subtest B-DP3: SUCCESS (8.072s)
[599.938986] Starting dynamic subtest: C-DP3
[607.994386] Dynamic subtest C-DP3: SUCCESS (8.067s)
[608.010249] Starting dynamic subtest: D-DP3
[616.069703] Dynamic subtest D-DP3: SUCCESS (8.071s)
[616.071856] Subtest blocking-wf_vblank: SUCCESS (32.374s)
[616.410826] [055/156] (550s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[616.605589] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[616.607405] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[616.802262] [056/156] (549s left) syncobj_basic (bad-destroy-pad)
[616.886946] Starting subtest: bad-destroy-pad
[616.887994] Subtest bad-destroy-pad: SUCCESS (0.000s)
[617.054218] [057/156] (549s left) kms_plane (plane-position-hole-dpms)
[617.241758] Starting subtest: plane-position-hole-dpms
[617.677715] Starting dynamic subtest: pipe-A-plane-1
[618.371730] Dynamic subtest pipe-A-plane-1: SUCCESS (0.692s)
[618.395954] Starting dynamic subtest: pipe-A-plane-2
[619.077745] Dynamic subtest pipe-A-plane-2: SUCCESS (0.705s)
[619.094645] Starting dynamic subtest: pipe-A-plane-3
[619.772448] Dynamic subtest pipe-A-plane-3: SUCCESS (0.693s)
[619.792724] Starting dynamic subtest: pipe-A-plane-4
[620.485873] Dynamic subtest pipe-A-plane-4: SUCCESS (0.712s)
[620.504555] Starting dynamic subtest: pipe-A-plane-5
[620.510587] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[620.893113] Starting dynamic subtest: pipe-B-plane-1
[621.491886] Dynamic subtest pipe-B-plane-1: SUCCESS (0.612s)
[621.506854] Starting dynamic subtest: pipe-B-plane-2
[622.143696] Dynamic subtest pipe-B-plane-2: SUCCESS (0.651s)
[622.157800] Starting dynamic subtest: pipe-B-plane-3
[622.794502] Dynamic subtest pipe-B-plane-3: SUCCESS (0.650s)
[622.808545] Starting dynamic subtest: pipe-B-plane-4
[623.445466] Dynamic subtest pipe-B-plane-4: SUCCESS (0.650s)
[623.459534] Starting dynamic subtest: pipe-B-plane-5
[623.464563] Dynamic subtest pipe-B-plane-5: SUCCESS (0.017s)
[623.465519] Subtest plane-position-hole-dpms: SUCCESS (6.221s)
[623.756109] [058/156] (543s left) kms_chamelium_color (ctm-0-50)
[623.948916] Subtest ctm-0-50: SKIP (0.000s)
[624.012932] [059/156] (542s left) kms_properties (plane-properties-legacy)
[624.208825] Starting subtest: plane-properties-legacy
[624.209714] Starting dynamic subtest: pipe-A-DP-3
[624.731096] Dynamic subtest pipe-A-DP-3: SUCCESS (0.520s)
[624.756530] Starting dynamic subtest: pipe-B-DP-3
[625.282361] Dynamic subtest pipe-B-DP-3: SUCCESS (0.547s)
[625.299522] Starting dynamic subtest: pipe-C-DP-3
[625.810593] Dynamic subtest pipe-C-DP-3: SUCCESS (0.527s)
[625.827460] Starting dynamic subtest: pipe-D-DP-3
[626.351925] Dynamic subtest pipe-D-DP-3: SUCCESS (0.538s)
[626.352847] Subtest plane-properties-legacy: SUCCESS (2.143s)
[626.654034] [060/156] (540s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[626.738880] Starting subtest: wait-all-for-submit-delayed-submit
[626.840846] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[626.963178] [061/156] (540s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[627.160737] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[627.162508] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[627.369807] [062/156] (539s left) kms_psr (pr-sprite-blt)
[627.555842] Subtest pr-sprite-blt: SKIP (0.000s)
[627.626106] [063/156] (539s left) kms_frontbuffer_tracking (fbc-tiling-4)
[627.822618] Starting subtest: fbc-tiling-4
[630.543752] Subtest fbc-tiling-4: SUCCESS (2.720s)
[630.747473] [064/156] (536s left) gem_userptr_blits (userfault)
[630.838572] Starting subtest: userfault
[630.841826] Subtest userfault: SUCCESS (0.005s)
[631.016282] [065/156] (536s left) gem_exec_reloc (basic-wc-noreloc)
[631.109609] Subtest basic-wc-noreloc: SKIP (0.000s)
[631.192640] [066/156] (536s left) gem_exec_whisper (basic-contexts-all)
[631.284999] Starting subtest: basic-contexts-all
[653.290803] Subtest basic-contexts-all: SUCCESS (21.997s)
[653.525306] [067/156] (513s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[653.719364] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[653.721109] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[653.882002] [068/156] (513s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[654.076683] Starting subtest: hdr-1p-pri-indfb-multidraw
[656.004341] Subtest hdr-1p-pri-indfb-multidraw: SUCCESS (1.929s)
[656.192745] [069/156] (511s left) kms_vblank (invalid)
[656.386075] Starting subtest: invalid
[656.386945] Starting dynamic subtest: pipe-A-DP-3
[656.888137] Dynamic subtest pipe-A-DP-3: SUCCESS (0.501s)
[656.889261] Subtest invalid: SUCCESS (0.503s)
[657.165883] [070/156] (510s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[657.361596] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[657.363380] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[657.531231] [071/156] (510s left) prime_busy (after)
[657.614930] Starting subtest: after
[657.619840] Starting dynamic subtest: rcs0
[657.670191] Dynamic subtest rcs0: SUCCESS (0.050s)
[657.686104] Starting dynamic subtest: bcs0
[657.722447] Dynamic subtest bcs0: SUCCESS (0.051s)
[657.746654] Starting dynamic subtest: vcs0
[657.763093] Dynamic subtest vcs0: SUCCESS (0.039s)
[657.786880] Starting dynamic subtest: vcs1
[657.803602] Dynamic subtest vcs1: SUCCESS (0.039s)
[657.822721] Starting dynamic subtest: vecs0
[657.844669] Dynamic subtest vecs0: SUCCESS (0.040s)
[657.861925] Starting dynamic subtest: vecs1
[657.884040] Dynamic subtest vecs1: SUCCESS (0.038s)
[657.901466] Starting dynamic subtest: ccs0
[657.923262] Dynamic subtest ccs0: SUCCESS (0.038s)
[658.038361] Subtest after: SUCCESS (0.422s)
[658.242002] [072/156] (509s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[658.435583] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[658.437322] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[658.623382] [073/156] (509s left) syncobj_timeline (multi-wait-submitted-signaled)
[658.705792] Starting subtest: multi-wait-submitted-signaled
[658.706712] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[658.831456] [074/156] (509s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[659.028943] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[659.030642] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[659.234300] [075/156] (509s left) gem_exec_schedule (u-fairslice-all)
[659.333341] Starting subtest: u-fairslice-all
[661.448574] Subtest u-fairslice-all: SUCCESS (2.116s)
[661.885659] [076/156] (506s left) kms_color (deep-color)
[662.079737] Starting subtest: deep-color
[665.782012] Starting dynamic subtest: pipe-A-DP-3-gamma
[671.368647] Dynamic subtest pipe-A-DP-3-gamma: SUCCESS (5.588s)
[671.384343] Starting dynamic subtest: pipe-A-DP-3-degamma
[677.234614] Dynamic subtest pipe-A-DP-3-degamma: SUCCESS (5.864s)
[677.255682] Starting dynamic subtest: pipe-A-DP-3-ctm
[683.105296] Dynamic subtest pipe-A-DP-3-ctm: SUCCESS (5.870s)
[686.743198] Starting dynamic subtest: pipe-B-DP-3-gamma
[692.566888] Dynamic subtest pipe-B-DP-3-gamma: SUCCESS (5.857s)
[692.588258] Starting dynamic subtest: pipe-B-DP-3-degamma
[698.425675] Dynamic subtest pipe-B-DP-3-degamma: SUCCESS (5.857s)
[698.442868] Starting dynamic subtest: pipe-B-DP-3-ctm
[704.299768] Dynamic subtest pipe-B-DP-3-ctm: SUCCESS (5.872s)
[707.983208] Starting dynamic subtest: pipe-C-DP-3-gamma
[713.792635] Dynamic subtest pipe-C-DP-3-gamma: SUCCESS (5.841s)
[713.809867] Starting dynamic subtest: pipe-C-DP-3-degamma
[719.636571] Dynamic subtest pipe-C-DP-3-degamma: SUCCESS (5.841s)
[719.658812] Starting dynamic subtest: pipe-C-DP-3-ctm
[725.485776] Dynamic subtest pipe-C-DP-3-ctm: SUCCESS (5.846s)
[729.223059] Starting dynamic subtest: pipe-D-DP-3-gamma
[735.070441] Dynamic subtest pipe-D-DP-3-gamma: SUCCESS (5.875s)
[735.094633] Starting dynamic subtest: pipe-D-DP-3-degamma
[740.925782] Dynamic subtest pipe-D-DP-3-degamma: SUCCESS (5.853s)
[740.949864] Starting dynamic subtest: pipe-D-DP-3-ctm
[746.797253] Dynamic subtest pipe-D-DP-3-ctm: SUCCESS (5.868s)
[746.798288] Subtest deep-color: SUCCESS (84.708s)
[747.072945] [077/156] (421s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[747.271656] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[747.273346] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[747.473453] [078/156] (421s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[747.667909] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[747.669635] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[747.830828] [079/156] (420s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[747.914333] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[747.916790] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[748.177323] [080/156] (420s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[748.369853] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[751.642830] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.272s)
[751.881619] [081/156] (416s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[752.076481] Starting subtest: hdr-rgb565-draw-mmap-wc
[752.078264] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[752.246464] [082/156] (416s left) perf (global-sseu-config-invalid)
[752.670753] Starting subtest: global-sseu-config-invalid
[752.672530] Subtest global-sseu-config-invalid: SKIP (0.000s)
[752.728579] [083/156] (416s left) kms_pipe_crc_basic (nonblocking-crc)
[752.918319] Starting subtest: nonblocking-crc
[752.920837] Starting dynamic subtest: pipe-A-DP-3
[753.653284] Dynamic subtest pipe-A-DP-3: SUCCESS (0.730s)
[753.680919] Starting dynamic subtest: pipe-B-DP-3
[754.320097] Dynamic subtest pipe-B-DP-3: SUCCESS (0.663s)
[754.346795] Starting dynamic subtest: pipe-C-DP-3
[754.977719] Dynamic subtest pipe-C-DP-3: SUCCESS (0.654s)
[754.996671] Starting dynamic subtest: pipe-D-DP-3
[755.625133] Dynamic subtest pipe-D-DP-3: SUCCESS (0.644s)
[755.626009] Subtest nonblocking-crc: SUCCESS (2.705s)
[755.925239] [084/156] (413s left) syncobj_wait (wait-delayed-signal)
[756.006788] Starting subtest: wait-delayed-signal
[756.108285] Subtest wait-delayed-signal: SUCCESS (0.101s)
[756.272125] [085/156] (412s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[756.462725] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[756.464540] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[756.577297] [086/156] (412s left) gem_busy (extended)
[756.853629] Starting subtest: extended
[756.854602] Starting dynamic subtest: rcs0
[756.944729] Dynamic subtest rcs0: SUCCESS (0.090s)
[756.964319] Starting dynamic subtest: bcs0
[756.989797] Dynamic subtest bcs0: SUCCESS (0.043s)
[757.008755] Starting dynamic subtest: vcs0
[757.032078] Dynamic subtest vcs0: SUCCESS (0.041s)
[757.054768] Starting dynamic subtest: vcs1
[757.076218] Dynamic subtest vcs1: SUCCESS (0.043s)
[757.098901] Starting dynamic subtest: vecs0
[757.121062] Dynamic subtest vecs0: SUCCESS (0.043s)
[757.141216] Starting dynamic subtest: vecs1
[757.162790] Dynamic subtest vecs1: SUCCESS (0.040s)
[757.183246] Starting dynamic subtest: ccs0
[757.203674] Dynamic subtest ccs0: SUCCESS (0.039s)
[757.204700] Subtest extended: SUCCESS (0.351s)
[757.500734] [087/156] (411s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[757.702786] Starting subtest: x-tiled-64bpp-rotate-270
[757.762613] Subtest x-tiled-64bpp-rotate-270: SKIP (0.059s)
[757.954751] [088/156] (411s left) gem_madvise (dontneed-after-mmap)
[758.003574] Starting subtest: dontneed-after-mmap
[758.048780] Subtest dontneed-after-mmap: SUCCESS (0.046s)
[758.255712] [089/156] (411s left) gem_spin_batch (legacy-resubmit)
[758.342663] Starting subtest: legacy-resubmit
[758.344913] Starting dynamic subtest: default
[758.372322] Dynamic subtest default: SUCCESS (0.028s)
[758.388621] Starting dynamic subtest: render
[758.389579] Dynamic subtest render: SUCCESS (0.002s)
[758.404830] Starting dynamic subtest: bsd
[758.406052] Dynamic subtest bsd: SUCCESS (0.002s)
[758.420561] Starting dynamic subtest: bsd1
[758.421581] Dynamic subtest bsd1: SUCCESS (0.002s)
[758.435779] Starting dynamic subtest: bsd2
[758.437028] Dynamic subtest bsd2: SUCCESS (0.001s)
[758.451122] Starting dynamic subtest: blt
[758.452148] Dynamic subtest blt: SUCCESS (0.002s)
[758.466202] Starting dynamic subtest: vebox
[758.467221] Dynamic subtest vebox: SUCCESS (0.002s)
[758.468284] Subtest legacy-resubmit: SUCCESS (0.048s)
[758.705697] [090/156] (410s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[758.892173] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[758.894714] Starting dynamic subtest: pipe-A-DP-3
[758.902936] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[758.917329] Starting dynamic subtest: pipe-B-DP-3
[758.925555] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[758.939636] Starting dynamic subtest: pipe-C-DP-3
[758.948732] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[758.962623] Starting dynamic subtest: pipe-D-DP-3
[758.973750] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[758.975956] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.007s)
[759.408482] [091/156] (410s left) gem_eio (create)
[759.696714] Starting subtest: create
[760.145533] Subtest create: SUCCESS (0.450s)
[760.375382] [092/156] (409s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[760.574516] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[760.576329] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[760.782700] [093/156] (409s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[760.981608] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[760.983378] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[761.181132] [094/156] (408s left) gem_pipe_control_store_loop (fresh-buffer)
[761.267194] Starting subtest: fresh-buffer
[763.444680] Subtest fresh-buffer: SUCCESS (2.176s)
[763.628969] [095/156] (406s left) kms_flip (basic-plain-flip)
[763.819245] Starting subtest: basic-plain-flip
[763.824041] Starting dynamic subtest: A-DP3
[764.694978] Dynamic subtest A-DP3: SUCCESS (0.870s)
[764.744431] Starting dynamic subtest: B-DP3
[765.512972] Dynamic subtest B-DP3: SUCCESS (0.811s)
[765.537103] Starting dynamic subtest: C-DP3
[766.292549] Dynamic subtest C-DP3: SUCCESS (0.773s)
[766.308487] Starting dynamic subtest: D-DP3
[767.082010] Dynamic subtest D-DP3: SUCCESS (0.788s)
[767.084446] Subtest basic-plain-flip: SUCCESS (3.264s)
[767.455981] [096/156] (402s left) kms_flip (2x-flip-vs-panning)
[767.648134] Starting subtest: 2x-flip-vs-panning
[767.663305] Subtest 2x-flip-vs-panning: SKIP (0.015s)
[767.843305] [097/156] (402s left) gen9_exec_parse (bb-start-far)
[767.932468] Subtest bb-start-far: SKIP (0.000s)
[768.013243] [098/156] (402s left) gem_exec_fence (keep-in-fence)
[768.262080] Starting subtest: keep-in-fence
[768.262985] Starting dynamic subtest: rcs0
[768.348972] Dynamic subtest rcs0: SUCCESS (0.086s)
[768.366090] Starting dynamic subtest: bcs0
[768.403239] Dynamic subtest bcs0: SUCCESS (0.053s)
[768.433987] Starting dynamic subtest: vcs0
[768.463289] Dynamic subtest vcs0: SUCCESS (0.058s)
[768.496206] Starting dynamic subtest: vcs1
[768.526025] Dynamic subtest vcs1: SUCCESS (0.061s)
[768.553209] Starting dynamic subtest: vecs0
[768.581635] Dynamic subtest vecs0: SUCCESS (0.054s)
[768.600828] Starting dynamic subtest: vecs1
[768.636100] Dynamic subtest vecs1: SUCCESS (0.053s)
[768.662204] Starting dynamic subtest: ccs0
[768.866892] Dynamic subtest ccs0: SUCCESS (0.229s)
[768.868608] Subtest keep-in-fence: SUCCESS (0.606s)
[769.648347] [099/156] (400s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[769.727896] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[769.830624] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[769.991303] [100/156] (400s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[770.179960] Starting subtest: primary-x-tiled-reflect-x-180
[780.857657] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.674s)
[781.311748] [101/156] (389s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[781.512851] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[782.264723] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.752s)
[782.496638] [102/156] (388s left) kms_invalid_mode (bad-htotal)
[782.687788] Starting subtest: bad-htotal
[782.688694] Starting dynamic subtest: pipe-A-DP-3
[782.775518] Dynamic subtest pipe-A-DP-3: SUCCESS (0.086s)
[782.799001] Starting dynamic subtest: pipe-B-DP-3
[782.800276] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[782.819467] Starting dynamic subtest: pipe-C-DP-3
[782.820407] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[782.835210] Starting dynamic subtest: pipe-D-DP-3
[782.836047] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[782.836920] Subtest bad-htotal: SUCCESS (0.098s)
[783.058517] [103/156] (387s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[783.144795] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[783.254222] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.109s)
[783.440513] [104/156] (387s left) gem_mmap_gtt (big-copy-odd)
[783.523608] Subtest big-copy-odd: SKIP (0.000s)
[783.595980] [105/156] (387s left) kms_frontbuffer_tracking (psrhdr-2p-pri-indfb-multidraw)
[783.797914] Starting subtest: psrhdr-2p-pri-indfb-multidraw
[783.799676] Subtest psrhdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[783.941284] [106/156] (387s left) gem_flink_race (flink_close)
[783.990839] Starting subtest: flink_close
[789.083868] Subtest flink_close: SUCCESS (5.094s)
[789.215432] [107/156] (381s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[789.441622] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[789.443390] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[789.602365] [108/156] (381s left) gem_ctx_exec (basic-norecovery)
[789.683673] Starting subtest: basic-norecovery
[790.067661] Subtest basic-norecovery: SUCCESS (0.383s)
[790.218714] [109/156] (380s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[790.411474] Starting subtest: psr-rgb101010-draw-blt
[790.413343] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[790.562304] [110/156] (380s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[790.758657] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[790.760381] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[790.909608] [111/156] (380s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[791.102570] Starting subtest: fbc-shrfb-scaledprimary
[792.444457] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.342s)
[792.714298] [112/156] (378s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[792.910741] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[792.912442] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[793.060721] [113/156] (378s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[793.262640] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[794.010124] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.747s)
[794.227872] [114/156] (377s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[794.422706] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[794.424464] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[794.550939] [115/156] (377s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt)
[794.741921] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt
[794.743636] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[794.894937] [116/156] (376s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[795.089631] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[795.091406] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[795.240784] [117/156] (376s left) kms_psr (fbc-psr2-primary-render)
[795.431311] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[795.492835] [118/156] (376s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[795.688436] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[795.690187] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[795.843382] [119/156] (376s left) kms_rotation_crc (multiplane-rotation)
[796.035881] Starting subtest: multiplane-rotation
[826.073261] Subtest multiplane-rotation: SUCCESS (30.042s)
[826.301197] [120/156] (345s left) kms_lease (invalid-create-leases)
[826.498777] Starting subtest: invalid-create-leases
[826.507855] Subtest invalid-create-leases: SUCCESS (0.009s)
[826.671347] [121/156] (345s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[826.864854] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[827.659517] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (0.795s)
[827.894983] [122/156] (344s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[828.090669] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[828.092435] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[828.266792] [123/156] (344s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[828.456197] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[828.458751] Starting dynamic subtest: pipe-A-valid-mode
[830.298943] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.839s)
[830.300362] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SUCCESS (1.842s)
[830.592835] [124/156] (341s left) kms_cursor_crc (cursor-offscreen-256x85)
[831.029393] Starting subtest: cursor-offscreen-256x85
[831.034018] Starting dynamic subtest: pipe-A-DP-3
[833.615287] Dynamic subtest pipe-A-DP-3: SUCCESS (2.580s)
[833.667916] Starting dynamic subtest: pipe-D-DP-3
[836.161613] Dynamic subtest pipe-D-DP-3: SUCCESS (2.507s)
[836.162555] Subtest cursor-offscreen-256x85: SUCCESS (5.132s)
[836.517462] [125/156] (336s left) kms_big_fb (yf-tiled-addfb)
[836.718478] Starting subtest: yf-tiled-addfb
[836.720278] Subtest yf-tiled-addfb: SKIP (0.000s)
[836.871554] [126/156] (335s left) gem_userptr_blits (dmabuf-unsync)
[836.960143] Subtest dmabuf-unsync: SKIP (0.000s)
[837.111374] [127/156] (335s left) kms_cursor_crc (cursor-random-256x256)
[837.524091] Starting subtest: cursor-random-256x256
[837.528820] Starting dynamic subtest: pipe-A-DP-3
[842.035905] Dynamic subtest pipe-A-DP-3: SUCCESS (4.506s)
[842.095191] Starting dynamic subtest: pipe-D-DP-3
[846.638748] Dynamic subtest pipe-D-DP-3: SUCCESS (4.558s)
[846.639807] Subtest cursor-random-256x256: SUCCESS (9.114s)
[847.074095] [128/156] (325s left) kms_chamelium_edid (hdmi-mode-timings)
[847.352562] Subtest hdmi-mode-timings: SKIP (0.000s)
[847.551791] [129/156] (325s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[847.745019] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[847.801109] [130/156] (325s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[847.997608] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[847.999325] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[848.160295] [131/156] (324s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[848.351595] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[848.353323] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[848.563987] [132/156] (324s left) gem_mmap_wc (write-gtt-read-wc)
[848.645484] Subtest write-gtt-read-wc: SKIP (0.000s)
[848.718641] [133/156] (324s left) kms_getfb (getfb-handle-protection)
[848.927770] Starting subtest: getfb-handle-protection
[848.941672] Subtest getfb-handle-protection: SUCCESS (0.015s)
[849.163300] [134/156] (324s left) kms_vblank (ts-continuation-idle-hang)
[849.352130] Starting subtest: ts-continuation-idle-hang
[849.354618] Starting dynamic subtest: pipe-A-DP-3
[876.014595] Dynamic subtest pipe-A-DP-3: SUCCESS (26.658s)
[876.032961] Starting dynamic subtest: pipe-D-DP-3
[901.011880] Dynamic subtest pipe-D-DP-3: SUCCESS (24.989s)
[901.012843] Subtest ts-continuation-idle-hang: SUCCESS (51.653s)
[901.325560] [135/156] (272s left) gem_create (create-invalid-size)
[901.414931] Starting subtest: create-invalid-size
[901.415813] Subtest create-invalid-size: SUCCESS (0.000s)
[901.708369] [136/156] (271s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[901.897840] Starting subtest: cursorA-vs-flipB-legacy
[901.899665] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[902.029983] [137/156] (271s left) gem_mmap_wc (write-prefaulted)
[902.111638] Subtest write-prefaulted: SKIP (0.000s)
[902.179228] [138/156] (271s left) perf (i915-ref-count)
[902.279222] Starting subtest: i915-ref-count
[902.414843] Subtest i915-ref-count: SUCCESS (0.134s)
[902.565294] [139/156] (271s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[902.758610] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[902.760376] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[902.886497] [140/156] (270s left) gem_ctx_engines (none)
[902.978485] Starting subtest: none
[902.981177] Subtest none: SUCCESS (0.003s)
[903.235107] [141/156] (270s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[903.428481] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[903.497641] [142/156] (270s left) i915_pm_rps (waitboost)
[903.587370] Starting subtest: waitboost
[907.185031] Subtest waitboost: SUCCESS (3.597s)
[907.325182] [143/156] (266s left) kms_cursor_edge_walk (128x128-top-bottom)
[907.517707] Starting subtest: 128x128-top-bottom
[907.518630] Starting dynamic subtest: pipe-A-DP-3
[911.013876] Dynamic subtest pipe-A-DP-3: SUCCESS (3.494s)
[911.036904] Starting dynamic subtest: pipe-D-DP-3
[914.368666] Dynamic subtest pipe-D-DP-3: SUCCESS (3.353s)
[914.369652] Subtest 128x128-top-bottom: SUCCESS (6.852s)
[914.685955] [144/156] (259s left) kms_atomic_interruptible (universal-setplane-primary)
[914.879717] Starting subtest: universal-setplane-primary
[914.881924] Starting dynamic subtest: pipe-A-DP-3
[921.223586] Dynamic subtest pipe-A-DP-3: SUCCESS (6.340s)
[921.224583] Subtest universal-setplane-primary: SUCCESS (6.342s)
[921.498281] [145/156] (252s left) gem_exec_big (single)
[921.592716] Starting subtest: single
[927.424626] Subtest single: SUCCESS (5.831s)
[928.212962] [146/156] (245s left) gem_exec_balancer (full-late)
[928.341972] Starting subtest: full-late
[930.514631] Subtest full-late: SUCCESS (2.172s)
[930.939802] [147/156] (243s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[931.140441] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[931.142372] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[931.326849] [148/156] (243s left) gem_lmem_swapping (verify-random)
[934.141929] Starting subtest: verify-random
[934.142890] Starting dynamic subtest: lmem0
[942.183637] Dynamic subtest lmem0: SUCCESS (8.039s)
[942.184640] Subtest verify-random: SUCCESS (8.040s)
[943.205995] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[943.206977] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[943.209248] [149/156] (231s left) gem_ctx_persistence (legacy-engines-cleanup)
[944.841544] Starting subtest: legacy-engines-cleanup
[944.845645] Starting dynamic subtest: render
[944.928675] Dynamic subtest render: SUCCESS (0.085s)
[944.946938] Starting dynamic subtest: bsd1
[944.965825] Dynamic subtest bsd1: SUCCESS (0.036s)
[944.986852] Starting dynamic subtest: bsd2
[945.007635] Dynamic subtest bsd2: SUCCESS (0.040s)
[945.026811] Starting dynamic subtest: blt
[945.041639] Dynamic subtest blt: SUCCESS (0.032s)
[945.059983] Starting dynamic subtest: vebox
[945.060929] Dynamic subtest vebox: SUCCESS (0.017s)
[945.061950] Subtest legacy-engines-cleanup: SUCCESS (0.221s)
[945.163405] [FACT gem_ctx_persistence (legacy-engines-cleanup)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[945.165972] [FACT gem_ctx_persistence (legacy-engines-cleanup)] new: kernel.kmod_is_loaded.i915: true
[945.168848] [150/156] (229s left) core_setmaster (master-drop-set-shared-fd)
[945.303847] Starting subtest: master-drop-set-shared-fd
[945.335466] Subtest master-drop-set-shared-fd: SUCCESS (0.033s)
[945.387632] [151/156] (229s left) kms_addfb_basic (unused-pitches)
[945.468134] Starting subtest: unused-pitches
[945.469043] Subtest unused-pitches: SUCCESS (0.000s)
[945.737523] [152/156] (228s left) gem_mmap_wc (read)
[945.822682] Subtest read: SKIP (0.000s)
[945.901975] [153/156] (228s left) perf_pmu (faulting-read)
[945.976289] Starting subtest: faulting-read
[945.977252] Starting dynamic subtest: fixed
[945.978135] Dynamic subtest fixed: SUCCESS (0.001s)
[945.978936] Subtest faulting-read: SUCCESS (0.002s)
[946.132694] [154/156] (228s left) gem_userptr_blits (access-control)
[946.234808] Starting subtest: access-control
[946.236635] Subtest access-control: SKIP (0.000s)
[946.390378] [155/156] (228s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[946.583720] Starting subtest: cursorB-vs-flipB-atomic-transitions
[946.585543] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[946.703421] [156/156] (228s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[946.898746] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[946.899671] Starting dynamic subtest: pipe-A-DP-3
[946.907969] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[946.921291] Starting dynamic subtest: pipe-B-DP-3
[946.929675] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[946.943993] Starting dynamic subtest: pipe-C-DP-3
[946.952625] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[946.965968] Starting dynamic subtest: pipe-D-DP-3
[946.976947] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[946.978907] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[947.417854] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_addfb_basic
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: core_auth
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_hdmi_inject
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_whisper
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_content_protection
results: parsing output: 14/ for test: testdisplay
results: parsing output: 15/ for test: drm_read
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: kms_fb_coherency
results: parsing output: 21/ for test: kms_plane
results: parsing output: 22/ for test: gem_mmap_offset
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_basic
results: parsing output: 29/ for test: i915_pm_rc6_residency
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: vgem_basic
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_dirtyfb
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_drm_fdinfo
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: i915_hangman
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_pread
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_basic
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_chamelium_color
results: parsing output: 58/ for test: kms_properties
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_color
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_pipe_crc_basic
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: gem_busy
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_madvise
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_pipe_control_store_loop
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gen9_exec_parse
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_invalid_mode
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_flink_race
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_ctx_exec
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: kms_chamelium_edid
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_mmap_wc
results: parsing output: 132/ for test: kms_getfb
results: parsing output: 133/ for test: kms_vblank
results: parsing output: 134/ for test: gem_create
results: parsing output: 135/ for test: kms_cursor_legacy
results: parsing output: 136/ for test: gem_mmap_wc
results: parsing output: 137/ for test: perf
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_ctx_engines
results: parsing output: 140/ for test: kms_psr2_sf
results: parsing output: 141/ for test: i915_pm_rps
results: parsing output: 142/ for test: kms_cursor_edge_walk
results: parsing output: 143/ for test: kms_atomic_interruptible
results: parsing output: 144/ for test: gem_exec_big
results: parsing output: 145/ for test: gem_exec_balancer
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_lmem_swapping
results: parsing output: 148/ for test: gem_ctx_persistence
results: parsing output: 149/ for test: core_setmaster
results: parsing output: 150/ for test: kms_addfb_basic
results: parsing output: 151/ for test: gem_mmap_wc
results: parsing output: 152/ for test: perf_pmu
results: parsing output: 153/ for test: gem_userptr_blits
results: parsing output: 154/ for test: kms_cursor_legacy
results: parsing output: 155/ for test: kms_ccs
Done.