[56.485342] Initializing watchdogs
[56.485384]   /dev/watchdog0
[56.500251] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.504872] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.507120] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.510525] [001/131] (960s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[56.641316] Starting subtest: yf-tiled-32bpp-rotate-270
[56.645958] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[56.730895] [002/131] (960s left) gem_eio (wait-immediate)
[56.867995] Starting subtest: wait-immediate
[57.069520] Subtest wait-immediate: SUCCESS (0.202s)
[57.211280] [003/131] (959s left) kms_atomic (atomic-plane-damage)
[57.302289] Starting subtest: atomic-plane-damage
[57.392794] Starting dynamic subtest: pipe-A-eDP-1
[57.922045] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.527s)
[57.924065] Subtest atomic-plane-damage: SUCCESS (0.620s)
[58.763925] [004/131] (958s left) kms_hdr (static-toggle-dpms)
[58.862078] Starting subtest: static-toggle-dpms
[58.868532] Subtest static-toggle-dpms: SKIP (0.000s)
[58.959555] [005/131] (958s left) gem_exec_schedule (u-fairslice-all)
[59.035373] Starting subtest: u-fairslice-all
[61.096543] Subtest u-fairslice-all: SUCCESS (2.063s)
[61.386194] [006/131] (955s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[61.499165] Starting subtest: plane-all-modeset-transition-internal-panels
[61.501347] Starting dynamic subtest: pipe-A-eDP-1
[62.377104] Dynamic subtest pipe-A-eDP-1: FAIL (0.310s)
[62.387088] Starting dynamic subtest: pipe-B-eDP-1
[62.808271] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.997s)
[63.075431] Subtest plane-all-modeset-transition-internal-panels: FAIL (1.575s)
[63.915493] [007/131] (953s left) syncobj_wait (multi-wait-for-submit-signaled)
[63.965362] Starting subtest: multi-wait-for-submit-signaled
[63.967639] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[64.053513] [008/131] (953s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[64.109677] Starting subtest: multi-wait-for-submit-unsubmitted
[64.218800] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[64.291730] [009/131] (953s left) kms_plane_multiple (2x-tiling-none)
[64.383226] Starting subtest: 2x-tiling-none
[64.387776] Subtest 2x-tiling-none: SKIP (0.000s)
[64.452217] [010/131] (952s left) fbdev (unaligned-read)
[64.505786] Starting subtest: unaligned-read
[64.522108] Subtest unaligned-read: SUCCESS (0.016s)
[64.588460] [011/131] (952s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[64.651758] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[64.713502] [012/131] (952s left) gem_exec_fence (syncobj-unused-fence)
[65.145066] Starting subtest: syncobj-unused-fence
[65.150140] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[66.402259] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[66.405342] [013/131] (951s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[66.515533] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[66.519593] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[66.598798] [014/131] (950s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[66.688876] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[66.691214] Starting dynamic subtest: pipe-A-eDP-1
[66.714357] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.723871] Starting dynamic subtest: pipe-B-eDP-1
[66.745649] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.753610] Starting dynamic subtest: pipe-C-eDP-1
[66.775210] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.783912] Starting dynamic subtest: pipe-D-eDP-1
[66.806752] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.811337] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[68.896406] [015/131] (948s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[68.996238] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[69.000413] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[69.093495] [016/131] (948s left) i915_pm_rpm (gem-mmap-type)
[70.623958] Starting subtest: gem-mmap-type
[70.626422] Starting dynamic subtest: wb-smem0
[74.707871] Dynamic subtest wb-smem0: SUCCESS (4.087s)
[74.717744] Starting dynamic subtest: wc-smem0
[77.874892] Dynamic subtest wc-smem0: SUCCESS (3.166s)
[77.884622] Starting dynamic subtest: uc-smem0
[81.051978] Dynamic subtest uc-smem0: SUCCESS (3.175s)
[81.054274] Subtest gem-mmap-type: SUCCESS (10.429s)
[81.152127] [017/131] (936s left) prime_self_import (basic-with_two_bos)
[81.186370] Starting subtest: basic-with_two_bos
[81.214893] Subtest basic-with_two_bos: SUCCESS (0.028s)
[81.312341] [018/131] (936s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[81.404386] Starting subtest: multiplane-rotation-cropping-bottom
[98.887548] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.482s)
[99.013843] [019/131] (918s left) gem_ctx_shared (q-smoketest-all)
[99.087244] Starting subtest: Q-smoketest-all
[131.465665] Subtest Q-smoketest-all: SUCCESS (32.329s)
[132.387679] [020/131] (885s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[132.492742] Starting subtest: psr-rgb101010-draw-render
[140.007075] Subtest psr-rgb101010-draw-render: SUCCESS (7.518s)
[140.134985] [021/131] (877s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[140.529056] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[141.346143] [022/131] (876s left) kms_prop_blob (invalid-get-prop)
[141.419795] Starting subtest: invalid-get-prop
[141.422197] Subtest invalid-get-prop: SUCCESS (0.000s)
[141.523736] [023/131] (876s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[141.634071] Starting subtest: fbc-rgb101010-draw-blt
[146.255586] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.624s)
[147.373768] [024/131] (870s left) kms_psr (fbc-pr-dpms)
[147.465056] Starting subtest: fbc-pr-dpms
[147.469133] Subtest fbc-pr-dpms: SKIP (0.000s)
[147.548686] [025/131] (870s left) gem_eio (in-flight-internal-immediate)
[147.797838] Starting subtest: in-flight-internal-immediate
[149.440274] Subtest in-flight-internal-immediate: SUCCESS (1.641s)
[149.556504] [026/131] (868s left) kms_flip (2x-flip-vs-modeset)
[149.656849] Starting subtest: 2x-flip-vs-modeset
[149.668681] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[149.749156] [027/131] (868s left) kms_rotation_crc (exhaust-fences)
[149.839906] Starting subtest: exhaust-fences
[149.843854] Subtest exhaust-fences: SKIP (0.000s)
[149.912613] [028/131] (868s left) gem_mmap_wc (write-cpu-read-wc)
[149.963357] Subtest write-cpu-read-wc: SKIP (0.000s)
[150.031629] [029/131] (868s left) gem_userptr_blits (create-destroy-sync)
[150.090144] Starting subtest: create-destroy-sync
[155.159995] Subtest create-destroy-sync: SUCCESS (5.016s)
[155.251987] [030/131] (862s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[155.352397] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[155.356494] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[155.441236] [031/131] (862s left) gem_eio (in-flight-contexts-1us)
[155.688707] Starting subtest: in-flight-contexts-1us
[167.350045] Subtest in-flight-contexts-1us: SUCCESS (11.660s)
[167.518751] [032/131] (850s left) gem_lmem_swapping (heavy-verify-multi)
[167.566120] Subtest heavy-verify-multi: SKIP (0.000s)
[167.650940] [033/131] (850s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[167.750101] Starting subtest: bad-aux-stride-y-tiled-ccs
[167.752426] Starting dynamic subtest: pipe-A-eDP-1
[167.774719] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[167.783978] Starting dynamic subtest: pipe-B-eDP-1
[167.805176] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[167.813411] Starting dynamic subtest: pipe-C-eDP-1
[167.834962] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[167.843237] Starting dynamic subtest: pipe-D-eDP-1
[167.865558] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[167.869967] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[169.934658] [034/131] (848s left) perf_pmu (semaphore-wait-idle)
[169.972119] Starting subtest: semaphore-wait-idle
[169.974510] Starting dynamic subtest: rcs0
[170.498631] Dynamic subtest rcs0: SUCCESS (0.524s)
[170.510856] Starting dynamic subtest: bcs0
[171.012865] Dynamic subtest bcs0: SUCCESS (0.511s)
[171.023375] Starting dynamic subtest: vcs0
[171.527575] Dynamic subtest vcs0: SUCCESS (0.513s)
[171.539752] Starting dynamic subtest: vcs1
[172.041354] Dynamic subtest vcs1: SUCCESS (0.511s)
[172.052897] Starting dynamic subtest: vecs0
[172.555078] Dynamic subtest vecs0: SUCCESS (0.510s)
[172.565788] Starting dynamic subtest: ccs0
[173.069858] Dynamic subtest ccs0: SUCCESS (0.513s)
[173.072715] Subtest semaphore-wait-idle: SUCCESS (3.097s)
[174.386764] [035/131] (844s left) kms_busy (extended-pageflip-hang-newfb)
[174.486653] Starting subtest: extended-pageflip-hang-newfb
[174.488880] Starting dynamic subtest: pipe-A
[201.093099] Dynamic subtest pipe-A: SUCCESS (26.604s)
[201.102732] Starting dynamic subtest: pipe-D
[216.119404] Dynamic subtest pipe-D: SUCCESS (15.024s)
[216.121635] Subtest extended-pageflip-hang-newfb: SUCCESS (41.632s)
[217.002718] [036/131] (801s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[217.067259] Starting subtest: yf-tiled-ccs-to-yf-tiled
[217.071659] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[217.252460] [037/131] (801s left) gem_exec_fence (basic-wait)
[217.420774] Starting subtest: basic-wait
[217.423306] Starting dynamic subtest: rcs0
[217.496759] Dynamic subtest rcs0: SUCCESS (0.076s)
[217.507796] Starting dynamic subtest: bcs0
[217.548473] Dynamic subtest bcs0: SUCCESS (0.050s)
[217.559440] Starting dynamic subtest: vcs0
[217.601175] Dynamic subtest vcs0: SUCCESS (0.051s)
[217.611824] Starting dynamic subtest: vcs1
[217.655893] Dynamic subtest vcs1: SUCCESS (0.053s)
[217.667928] Starting dynamic subtest: vecs0
[217.711033] Dynamic subtest vecs0: SUCCESS (0.053s)
[217.724812] Starting dynamic subtest: ccs0
[217.764052] Dynamic subtest ccs0: SUCCESS (0.052s)
[217.766597] Subtest basic-wait: SUCCESS (0.345s)
[219.380340] [038/131] (799s left) gem_userptr_blits (coherency-unsync)
[219.439633] Subtest coherency-unsync: SKIP (0.000s)
[219.553763] [039/131] (799s left) perf (invalid-oa-exponent)
[219.671839] Starting subtest: invalid-oa-exponent
[219.687763] Subtest invalid-oa-exponent: SUCCESS (0.015s)
[219.726537] [040/131] (798s left) kms_color_pipeline (plane-lut1d-lut1d)
[219.824626] Starting subtest: plane-lut1d-lut1d
[219.970516] Starting dynamic subtest: pipe-A-plane-0
[220.137623] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[220.152315] Starting dynamic subtest: pipe-A-plane-1
[220.281307] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[220.290905] Starting dynamic subtest: pipe-A-plane-2
[220.436707] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[221.621722] Starting dynamic subtest: pipe-B-plane-0
[221.782156] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[221.792281] Starting dynamic subtest: pipe-B-plane-1
[221.936524] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[221.946040] Starting dynamic subtest: pipe-B-plane-2
[222.126074] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[223.308943] Starting dynamic subtest: pipe-C-plane-0
[223.439313] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[223.451485] Starting dynamic subtest: pipe-C-plane-1
[223.583665] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[223.593262] Starting dynamic subtest: pipe-C-plane-2
[223.729912] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[224.934404] Starting dynamic subtest: pipe-D-plane-0
[225.081581] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[225.091493] Starting dynamic subtest: pipe-D-plane-1
[225.225391] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[225.235246] Starting dynamic subtest: pipe-D-plane-2
[225.369927] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[225.665777] Subtest plane-lut1d-lut1d: SUCCESS (5.841s)
[226.511407] [041/131] (792s left) prime_vgem (coherency-gtt)
[226.595945] Starting subtest: coherency-gtt
[226.600675] Subtest coherency-gtt: SKIP (0.000s)
[226.700422] [042/131] (792s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[226.793366] Starting subtest: 4-tiled-64bpp-rotate-90
[226.813713] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[226.915092] [043/131] (791s left) gem_vm_create (invalid-destroy)
[226.963838] Starting subtest: invalid-destroy
[226.968647] Subtest invalid-destroy: SUCCESS (0.002s)
[227.074574] [044/131] (791s left) kms_atomic_interruptible (legacy-pageflip)
[227.174200] Starting subtest: legacy-pageflip
[227.176480] Starting dynamic subtest: pipe-A-eDP-1
[234.613080] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.437s)
[234.615460] Subtest legacy-pageflip: SUCCESS (7.439s)
[235.455995] [045/131] (783s left) gem_exec_schedule (preempt-hang)
[235.631406] Starting subtest: preempt-hang
[235.633386] Starting dynamic subtest: rcs0
[235.862219] Dynamic subtest rcs0: SUCCESS (0.233s)
[235.875579] Starting dynamic subtest: bcs0
[236.088224] Dynamic subtest bcs0: SUCCESS (0.225s)
[236.097891] Starting dynamic subtest: vcs0
[236.304425] Dynamic subtest vcs0: SUCCESS (0.215s)
[236.315058] Starting dynamic subtest: vcs1
[236.521215] Dynamic subtest vcs1: SUCCESS (0.216s)
[236.531100] Starting dynamic subtest: vecs0
[236.742529] Dynamic subtest vecs0: SUCCESS (0.220s)
[236.754471] Starting dynamic subtest: ccs0
[236.973865] Dynamic subtest ccs0: SUCCESS (0.230s)
[236.976112] Subtest preempt-hang: SUCCESS (1.345s)
[237.454914] [046/131] (781s left) i915_query (hwconfig_table)
[237.506540] Starting subtest: hwconfig_table
[237.806624] Subtest hwconfig_table: SUCCESS (0.001s)
[237.846934] [047/131] (781s left) i915_drm_fdinfo (busy-check-all)
[237.891046] Starting subtest: busy-check-all
[237.893501] Starting dynamic subtest: rcs0
[237.898190] Dynamic subtest rcs0: SKIP (0.004s)
[237.908721] Starting dynamic subtest: bcs0
[237.913304] Dynamic subtest bcs0: SKIP (0.000s)
[237.922342] Starting dynamic subtest: vcs0
[237.926673] Dynamic subtest vcs0: SKIP (0.000s)
[237.935416] Starting dynamic subtest: vcs1
[237.939747] Dynamic subtest vcs1: SKIP (0.000s)
[237.948485] Starting dynamic subtest: vecs0
[237.952874] Dynamic subtest vecs0: SKIP (0.000s)
[237.961696] Starting dynamic subtest: ccs0
[237.965745] Dynamic subtest ccs0: SKIP (0.000s)
[237.969854] Subtest busy-check-all: SKIP (0.009s)
[238.008148] [048/131] (780s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[238.104181] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[238.211300] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s)
[238.294628] [049/131] (780s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[238.399913] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[241.929061] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.533s)
[243.065159] [050/131] (776s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[243.124039] Starting subtest: etime-single-wait-available-unsubmitted
[243.226491] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s)
[243.302600] [051/131] (775s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[243.393835] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[243.397690] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[243.474951] [052/131] (775s left) syncobj_wait (multi-wait-submitted-signaled)
[243.522764] Starting subtest: multi-wait-submitted-signaled
[243.524989] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[243.621922] [053/131] (775s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[243.676953] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[243.748680] [054/131] (775s left) kms_psr (psr-cursor-plane-move)
[243.840275] Starting subtest: psr-cursor-plane-move
[243.842433] Starting dynamic subtest: eDP-1
[245.558328] Dynamic subtest eDP-1: SUCCESS (1.718s)
[245.560533] Subtest psr-cursor-plane-move: SUCCESS (1.719s)
[246.442379] [055/131] (772s left) gem_exec_balancer (nop)
[246.508849] Starting subtest: nop
[293.325473] Subtest nop: SUCCESS (46.814s)
[293.626996] [056/131] (725s left) kms_content_protection (srm)
[293.784069] Starting subtest: srm
[293.791632] Subtest srm: SKIP (0.003s)
[293.928149] [057/131] (725s left) kms_vblank (wait-forked-hang)
[294.024286] Starting subtest: wait-forked-hang
[294.026317] Starting dynamic subtest: pipe-A-eDP-1
[321.057020] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.032s)
[321.071821] Starting dynamic subtest: pipe-D-eDP-1
[346.097680] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.037s)
[346.100057] Subtest wait-forked-hang: SUCCESS (52.073s)
[346.895403] [058/131] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[346.986488] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[346.990964] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[347.082634] [059/131] (672s left) gen9_exec_parse (batch-invalid-length)
[347.147683] Subtest batch-invalid-length: SKIP (0.000s)
[347.224023] [060/131] (672s left) i915_drm_fdinfo (virtual-idle)
[347.264792] Starting subtest: virtual-idle
[350.351862] Subtest virtual-idle: SUCCESS (3.085s)
[350.429674] [061/131] (669s left) core_hotunplug (unbind-rebind)
[350.515574] Starting subtest: unbind-rebind
[356.447405] Subtest unbind-rebind: SUCCESS (5.933s)
[356.487894] [062/131] (663s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[358.331311] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[367.021419] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.694s)
[367.146794] [063/131] (652s left) perf (low-oa-exponent-permissions)
[367.273881] Starting subtest: low-oa-exponent-permissions
[367.306191] Subtest low-oa-exponent-permissions: SUCCESS (0.032s)
[367.362343] [064/131] (652s left) kms_psr (pr-cursor-mmap-gtt)
[367.465018] Starting subtest: pr-cursor-mmap-gtt
[367.469336] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[367.552048] [065/131] (652s left) gem_userptr_blits (coherency-sync)
[367.619748] Starting subtest: coherency-sync
[367.962858] Subtest coherency-sync: SKIP (0.304s)
[368.078231] [066/131] (651s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[368.423288] Starting subtest: cursor-rapid-movement-512x170
[368.427029] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[368.552973] [067/131] (651s left) kms_flip (2x-absolute-wf_vblank)
[368.639693] Starting subtest: 2x-absolute-wf_vblank
[368.655211] Subtest 2x-absolute-wf_vblank: SKIP (0.015s)
[368.737266] [068/131] (651s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[368.847683] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[368.850553] Starting dynamic subtest: pipe-A
[368.911043] Dynamic subtest pipe-A: SUCCESS (0.065s)
[368.920727] Starting dynamic subtest: pipe-B
[370.018554] Dynamic subtest pipe-B: SUCCESS (1.107s)
[370.030554] Starting dynamic subtest: pipe-C
[371.128646] Dynamic subtest pipe-C: SUCCESS (1.109s)
[371.138337] Starting dynamic subtest: pipe-D
[372.257788] Dynamic subtest pipe-D: SUCCESS (1.128s)
[372.260138] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.413s)
[373.413316] [069/131] (646s left) kms_chamelium_color (ctm-blue-to-red)
[373.516423] Subtest ctm-blue-to-red: SKIP (0.000s)
[373.564986] [070/131] (646s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[373.656590] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[373.660944] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[373.745075] [071/131] (646s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[373.837795] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[373.839994] Starting dynamic subtest: pipe-A-eDP-1
[373.848859] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[373.859550] Starting dynamic subtest: pipe-B-eDP-1
[373.868626] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[373.880067] Starting dynamic subtest: pipe-C-eDP-1
[373.888193] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[373.897790] Starting dynamic subtest: pipe-D-eDP-1
[373.906148] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[373.910304] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[376.004383] [072/131] (644s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[376.098034] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[376.102142] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[376.170030] [073/131] (643s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[376.254167] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[376.258663] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[376.334973] [074/131] (643s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[376.436628] Starting subtest: x-tiled-64bpp-rotate-90
[376.456735] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[376.558393] [075/131] (643s left) api_intel_allocator (reopen-fork)
[376.609493] Starting subtest: reopen-fork
[379.965930] Subtest reopen-fork: SUCCESS (3.357s)
[380.042225] [076/131] (640s left) gem_pread (self)
[380.094508] Subtest self: SKIP (0.000s)
[380.159821] [077/131] (640s left) kms_lease (lease-unleased-crtc)
[380.262805] Starting subtest: lease-unleased-crtc
[380.264734] Starting dynamic subtest: pipe-A-eDP-1
[380.579474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.314s)
[380.594451] Starting dynamic subtest: pipe-B-eDP-1
[381.360469] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.775s)
[381.373857] Starting dynamic subtest: pipe-C-eDP-1
[381.376257] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[381.386501] Starting dynamic subtest: pipe-D-eDP-1
[381.388858] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[381.391105] Subtest lease-unleased-crtc: SUCCESS (1.112s)
[381.744122] [078/131] (638s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[381.836124] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[381.845308] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[381.973884] [079/131] (638s left) kms_psr (fbc-pr-primary-page-flip)
[382.070847] Starting subtest: fbc-pr-primary-page-flip
[382.075467] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[382.147500] [080/131] (638s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[382.258613] Starting subtest: y-tiled-64bpp-rotate-180
[382.262931] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[382.343251] [081/131] (638s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[382.435281] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[386.467203] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.034s)
[387.628391] [082/131] (632s left) gem_mmap_offset (isolation)
[387.689451] Starting subtest: isolation
[387.707134] Subtest isolation: SUCCESS (0.007s)
[387.811756] [083/131] (632s left) syncobj_timeline (wait-for-submit-complex)
[387.872059] Starting subtest: wait-for-submit-complex
[387.934031] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[388.010795] [084/131] (632s left) kms_chamelium_edid (hdmi-mode-timings)
[388.410289] Subtest hdmi-mode-timings: SKIP (0.000s)
[389.233317] [085/131] (631s left) kms_addfb_basic (unused-modifier)
[389.286666] Starting subtest: unused-modifier
[389.289051] Subtest unused-modifier: SUCCESS (0.000s)
[389.449800] [086/131] (631s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[389.550252] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[389.554451] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[389.652847] [087/131] (631s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[389.762510] Starting subtest: yf-tiled-8bpp-rotate-180
[389.766729] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[389.859877] [088/131] (630s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[389.916760] Starting subtest: multi-wait-for-submit-available-submitted
[389.919069] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[390.015620] [089/131] (630s left) prime_vgem (basic-write)
[390.090979] Starting subtest: basic-write
[390.099820] Subtest basic-write: SKIP (0.006s)
[390.220426] [090/131] (630s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[390.325227] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[390.338522] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[390.420825] [091/131] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[390.517539] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[390.521257] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[390.627460] [092/131] (630s left) kms_panel_fitting (atomic-fastset)
[390.713689] Starting subtest: atomic-fastset
[390.715534] Starting dynamic subtest: pipe-A-eDP-1
[390.852500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[390.862766] Starting dynamic subtest: pipe-B-eDP-1
[392.121251] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s)
[392.132526] Starting dynamic subtest: pipe-C-eDP-1
[393.319210] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s)
[393.329585] Starting dynamic subtest: pipe-D-eDP-1
[394.563022] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[394.565300] Subtest atomic-fastset: SUCCESS (3.851s)
[395.718795] [093/131] (625s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[395.778987] Starting subtest: basic-batch-kernel-default-cmd
[395.783535] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[395.964417] [094/131] (625s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[396.067314] Starting subtest: fbc-rgb565-draw-mmap-cpu
[400.080028] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.016s)
[401.235199] [095/131] (619s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[401.333499] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[408.262108] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.930s)
[408.415987] [096/131] (612s left) kms_cursor_crc (cursor-onscreen-64x64)
[408.610080] Starting subtest: cursor-onscreen-64x64
[408.612374] Starting dynamic subtest: pipe-A-eDP-1
[410.730840] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.118s)
[410.764918] Starting dynamic subtest: pipe-D-eDP-1
[413.509758] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s)
[413.512131] Subtest cursor-onscreen-64x64: SUCCESS (4.903s)
[414.308492] [097/131] (606s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[414.414631] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[414.418794] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[414.497453] [098/131] (606s left) kms_cursor_crc (cursor-sliding-256x85)
[414.758319] Starting subtest: cursor-sliding-256x85
[414.806796] Subtest cursor-sliding-256x85: SKIP (0.043s)
[414.993284] [099/131] (606s left) perf (gen12-unprivileged-single-ctx-counters)
[415.106542] Starting subtest: gen12-unprivileged-single-ctx-counters
[415.109254] Starting dynamic subtest: rcs0
[415.143769] Dynamic subtest rcs0: SUCCESS (0.037s)
[415.146145] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.038s)
[415.193087] [100/131] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[415.307217] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[415.310671] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[415.424133] [101/131] (605s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[415.519090] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[415.522473] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[415.588512] [102/131] (605s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[415.686991] Starting subtest: addfb25-y-tiled-small-legacy
[415.690372] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[415.780911] [103/131] (605s left) gem_ctx_shared (create-shared-gtt)
[415.856613] Starting subtest: create-shared-gtt
[418.009296] Subtest create-shared-gtt: SUCCESS (2.151s)
[418.402452] [104/131] (603s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[418.491068] Starting subtest: fbc-psr2-sprite-mmap-gtt
[418.493445] Starting dynamic subtest: eDP-1
[418.497888] Dynamic subtest eDP-1: SKIP (0.000s)
[418.502272] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[418.580510] [105/131] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[418.680630] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[418.684658] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[418.767548] [106/131] (602s left) syncobj_wait (multi-wait-for-submit-submitted)
[418.829857] Starting subtest: multi-wait-for-submit-submitted
[418.930410] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[419.009923] [107/131] (602s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[419.105076] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[419.108988] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[419.181550] [108/131] (602s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[419.236495] Starting subtest: multi-wait-all-available-submitted-signaled
[419.238474] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[419.350136] [109/131] (602s left) gem_render_copy (y-tiled-to-vebox-linear)
[419.416608] Starting subtest: y-tiled-to-vebox-linear
[419.420434] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[419.598653] [110/131] (602s left) prime_vgem (basic-fence-flip)
[419.678555] Starting subtest: basic-fence-flip
[419.981538] Subtest basic-fence-flip: SUCCESS (0.303s)
[420.079979] [111/131] (601s left) syncobj_timeline (wait-all-snapshot)
[420.144285] Starting subtest: wait-all-snapshot
[420.224753] Subtest wait-all-snapshot: SUCCESS (0.081s)
[420.307569] [112/131] (601s left) gem_softpin (evict-prime)
[420.357289] Starting subtest: evict-prime
[420.359554] Starting dynamic subtest: rcs0
[421.497228] Dynamic subtest rcs0: SUCCESS (1.139s)
[421.507722] Starting dynamic subtest: bcs0
[422.630343] Dynamic subtest bcs0: SUCCESS (1.131s)
[422.645033] Starting dynamic subtest: vcs0
[424.298226] Dynamic subtest vcs0: SUCCESS (1.664s)
[424.316043] Starting dynamic subtest: vcs1
[426.349929] Dynamic subtest vcs1: SUCCESS (2.049s)
[426.362752] Starting dynamic subtest: vecs0
[428.323067] Dynamic subtest vecs0: SUCCESS (1.971s)
[428.335350] Starting dynamic subtest: ccs0
[429.439590] Dynamic subtest ccs0: SUCCESS (1.115s)
[429.454517] Starting dynamic subtest: all
[431.269151] Dynamic subtest all: SUCCESS (1.825s)
[431.272351] Subtest evict-prime: SUCCESS (10.912s)
[431.368118] [113/131] (590s left) gem_caching (reads)
[431.440451] Subtest reads: SKIP (0.000s)
[431.517684] [114/131] (590s left) kms_tiled_display (basic-test-pattern)
[431.645448] Subtest basic-test-pattern: SKIP (0.000s)
[431.692389] [115/131] (590s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[431.782158] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[431.784415] Starting dynamic subtest: pipe-A-eDP-1
[465.762535] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.820s)
[465.779502] Starting dynamic subtest: pipe-B-eDP-1
[500.682586] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.483s)
[500.693808] Starting dynamic subtest: pipe-C-eDP-1
[535.643456] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.465s)
[535.654390] Starting dynamic subtest: pipe-D-eDP-1
[570.665572] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.486s)
[570.668087] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.262s)
[577.911046] [116/131] (450s left) kms_plane_alpha_blend (constant-alpha-max)
[578.034643] Starting subtest: constant-alpha-max
[578.331360] Starting dynamic subtest: pipe-A-eDP-1
[579.467260] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.133s)
[579.478486] Starting dynamic subtest: pipe-D-eDP-1
[581.127572] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.654s)
[581.129988] Subtest constant-alpha-max: SUCCESS (3.086s)
[581.972747] [117/131] (446s left) perf_pmu (module-unload)