[55.491250] Initializing watchdogs
[55.491298]   /dev/watchdog0
[55.505948] [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]
[55.510435] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.512715] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.515975] [001/133] (960s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[55.649180] Starting subtest: yf-tiled-32bpp-rotate-270
[55.653499] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[55.731986] [002/133] (960s left) gem_eio (wait-immediate)
[55.871909] Starting subtest: wait-immediate
[56.070783] Subtest wait-immediate: SUCCESS (0.199s)
[56.211528] [003/133] (959s left) kms_atomic (atomic-plane-damage)
[56.309246] Starting subtest: atomic-plane-damage
[56.393859] Starting dynamic subtest: pipe-A-eDP-1
[56.952117] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[56.954044] Subtest atomic-plane-damage: SUCCESS (0.642s)
[57.822133] [004/133] (958s left) kms_hdr (static-toggle-dpms)
[57.928054] Starting subtest: static-toggle-dpms
[57.934396] Subtest static-toggle-dpms: SKIP (0.000s)
[58.015040] [005/133] (958s left) gem_exec_schedule (u-fairslice-all)
[58.092238] Starting subtest: u-fairslice-all
[60.155035] Subtest u-fairslice-all: SUCCESS (2.062s)
[60.446273] [006/133] (955s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[60.534785] Starting subtest: plane-all-modeset-transition-internal-panels
[60.536992] Starting dynamic subtest: pipe-A-eDP-1
[61.870369] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.335s)
[62.148952] Starting dynamic subtest: pipe-B-eDP-1
[63.195530] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.056s)
[63.466323] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.934s)
[64.303313] [007/133] (951s left) syncobj_wait (multi-wait-for-submit-signaled)
[64.369921] Starting subtest: multi-wait-for-submit-signaled
[64.372384] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[64.475781] [008/133] (951s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[64.528873] Starting subtest: multi-wait-for-submit-unsubmitted
[64.636461] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[64.708920] [009/133] (951s left) kms_plane_multiple (2x-tiling-none)
[64.821018] Starting subtest: 2x-tiling-none
[64.825143] Subtest 2x-tiling-none: SKIP (0.000s)
[64.887318] [010/133] (951s left) fbdev (unaligned-read)
[64.921432] Starting subtest: unaligned-read
[64.937109] Subtest unaligned-read: SUCCESS (0.015s)
[64.989130] [011/133] (951s left) kms_pm_rpm (modeset-stress-extra-wait)
[66.519392] Starting subtest: modeset-stress-extra-wait
[120.789229] Subtest modeset-stress-extra-wait: SUCCESS (54.270s)
[120.894047] [012/133] (895s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[120.956850] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[121.012609] [013/133] (895s left) gem_exec_fence (syncobj-unused-fence)
[121.453885] Starting subtest: syncobj-unused-fence
[121.459942] Subtest syncobj-unused-fence: SUCCESS (0.006s)
[123.422891] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[123.426199] [014/133] (893s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[123.524246] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[123.528583] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[123.613557] [015/133] (892s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[123.700378] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[123.702826] Starting dynamic subtest: pipe-A-eDP-1
[123.725735] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[123.735544] Starting dynamic subtest: pipe-B-eDP-1
[123.757319] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[123.765663] Starting dynamic subtest: pipe-C-eDP-1
[123.787361] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[123.796910] Starting dynamic subtest: pipe-D-eDP-1
[123.819180] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[123.823247] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[125.928360] [016/133] (890s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[126.035641] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[126.040157] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[126.136533] [017/133] (890s left) i915_pm_rpm (gem-mmap-type)
[127.661016] Starting subtest: gem-mmap-type
[127.663617] Starting dynamic subtest: wb-smem0
[131.776983] Dynamic subtest wb-smem0: SUCCESS (4.117s)
[131.785411] Starting dynamic subtest: wc-smem0
[134.967534] Dynamic subtest wc-smem0: SUCCESS (3.190s)
[134.978289] Starting dynamic subtest: uc-smem0
[138.434779] Dynamic subtest uc-smem0: SUCCESS (3.467s)
[138.437095] Subtest gem-mmap-type: SUCCESS (10.776s)
[138.533542] [018/133] (878s left) prime_self_import (basic-with_two_bos)
[138.568785] Starting subtest: basic-with_two_bos
[138.582495] Subtest basic-with_two_bos: SUCCESS (0.015s)
[138.691034] [019/133] (878s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[138.782249] Starting subtest: multiplane-rotation-cropping-bottom
[156.254097] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.471s)
[156.382080] [020/133] (860s left) gem_ctx_shared (q-smoketest-all)
[156.464458] Starting subtest: Q-smoketest-all
[188.878840] Subtest Q-smoketest-all: SUCCESS (32.357s)
[190.365947] [021/133] (826s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[190.476846] Starting subtest: psr-rgb101010-draw-render
[197.860973] Subtest psr-rgb101010-draw-render: SUCCESS (7.386s)
[197.977145] [022/133] (818s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[198.363862] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[199.142349] [023/133] (817s left) kms_prop_blob (invalid-get-prop)
[199.202448] Starting subtest: invalid-get-prop
[199.204435] Subtest invalid-get-prop: SUCCESS (0.000s)
[199.305934] [024/133] (817s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[199.403363] Starting subtest: fbc-rgb101010-draw-blt
[203.982123] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.582s)
[205.178500] [025/133] (811s left) kms_psr (fbc-pr-dpms)
[205.275171] Starting subtest: fbc-pr-dpms
[205.279539] Subtest fbc-pr-dpms: SKIP (0.000s)
[205.347043] [026/133] (811s left) gem_eio (in-flight-internal-immediate)
[205.662576] Starting subtest: in-flight-internal-immediate
[207.328952] Subtest in-flight-internal-immediate: SUCCESS (1.666s)
[207.462340] [027/133] (809s left) kms_flip (2x-flip-vs-modeset)
[207.552471] Starting subtest: 2x-flip-vs-modeset
[207.561416] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[207.642081] [028/133] (809s left) kms_rotation_crc (exhaust-fences)
[207.742208] Starting subtest: exhaust-fences
[207.746222] Subtest exhaust-fences: SKIP (0.000s)
[207.816120] [029/133] (809s left) gem_mmap_wc (write-cpu-read-wc)
[207.882170] Subtest write-cpu-read-wc: SKIP (0.000s)
[207.944457] [030/133] (809s left) gem_userptr_blits (create-destroy-sync)
[208.005155] Starting subtest: create-destroy-sync
[213.021682] Subtest create-destroy-sync: SUCCESS (5.018s)
[213.147586] [031/133] (804s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[213.253300] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[213.257600] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[213.347803] [032/133] (803s left) gem_eio (in-flight-contexts-1us)
[213.578568] Starting subtest: in-flight-contexts-1us
[227.369279] Subtest in-flight-contexts-1us: SUCCESS (13.789s)
[227.537827] [033/133] (789s left) gem_lmem_swapping (heavy-verify-multi)
[227.585364] Subtest heavy-verify-multi: SKIP (0.000s)
[227.631292] [034/133] (789s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[227.718211] Starting subtest: bad-aux-stride-y-tiled-ccs
[227.720531] Starting dynamic subtest: pipe-A-eDP-1
[227.743314] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[227.753928] Starting dynamic subtest: pipe-B-eDP-1
[227.775315] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[227.784117] Starting dynamic subtest: pipe-C-eDP-1
[227.805489] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[227.813660] Starting dynamic subtest: pipe-D-eDP-1
[227.835054] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[227.839285] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[229.929391] [035/133] (787s left) perf_pmu (semaphore-wait-idle)
[229.976931] Starting subtest: semaphore-wait-idle
[229.979205] Starting dynamic subtest: rcs0
[230.491303] Dynamic subtest rcs0: SUCCESS (0.513s)
[230.503327] Starting dynamic subtest: bcs0
[231.005521] Dynamic subtest bcs0: SUCCESS (0.512s)
[231.017640] Starting dynamic subtest: vcs0
[231.519383] Dynamic subtest vcs0: SUCCESS (0.511s)
[231.530611] Starting dynamic subtest: vcs1
[232.036623] Dynamic subtest vcs1: SUCCESS (0.515s)
[232.047571] Starting dynamic subtest: vecs0
[232.550470] Dynamic subtest vecs0: SUCCESS (0.511s)
[232.563252] Starting dynamic subtest: ccs0
[233.067070] Dynamic subtest ccs0: SUCCESS (0.513s)
[233.069947] Subtest semaphore-wait-idle: SUCCESS (3.091s)
[234.389889] [036/133] (783s left) kms_busy (extended-pageflip-hang-newfb)
[234.488957] Starting subtest: extended-pageflip-hang-newfb
[234.491344] Starting dynamic subtest: pipe-A
[261.096297] Dynamic subtest pipe-A: SUCCESS (26.605s)
[261.106343] Starting dynamic subtest: pipe-D
[286.106086] Dynamic subtest pipe-D: SUCCESS (25.006s)
[286.108425] Subtest extended-pageflip-hang-newfb: SUCCESS (51.616s)
[286.984879] [037/133] (730s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[287.057601] Starting subtest: yf-tiled-ccs-to-yf-tiled
[287.061972] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[287.244776] [038/133] (730s left) gem_exec_fence (basic-wait)
[287.435957] Starting subtest: basic-wait
[287.438382] Starting dynamic subtest: rcs0
[287.534737] Dynamic subtest rcs0: SUCCESS (0.098s)
[287.546649] Starting dynamic subtest: bcs0
[287.592368] Dynamic subtest bcs0: SUCCESS (0.056s)
[287.603786] Starting dynamic subtest: vcs0
[287.651059] Dynamic subtest vcs0: SUCCESS (0.057s)
[287.663143] Starting dynamic subtest: vcs1
[287.714280] Dynamic subtest vcs1: SUCCESS (0.061s)
[287.726676] Starting dynamic subtest: vecs0
[287.780309] Dynamic subtest vecs0: SUCCESS (0.064s)
[287.792047] Starting dynamic subtest: ccs0
[287.839653] Dynamic subtest ccs0: SUCCESS (0.057s)
[287.842238] Subtest basic-wait: SUCCESS (0.405s)
[289.339262] [039/133] (728s left) gem_userptr_blits (coherency-unsync)
[289.421058] Subtest coherency-unsync: SKIP (0.000s)
[289.539881] [040/133] (728s left) perf (invalid-oa-exponent)
[289.686048] Starting subtest: invalid-oa-exponent
[289.716809] Subtest invalid-oa-exponent: SUCCESS (0.031s)
[289.771169] [041/133] (727s left) kms_color_pipeline (plane-lut1d-lut1d)
[289.868201] Starting subtest: plane-lut1d-lut1d
[290.020982] Starting dynamic subtest: pipe-A-plane-0
[290.199670] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[290.209774] Starting dynamic subtest: pipe-A-plane-1
[290.354330] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[290.364931] Starting dynamic subtest: pipe-A-plane-2
[290.499201] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[291.716886] Starting dynamic subtest: pipe-B-plane-0
[291.875156] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[291.885246] Starting dynamic subtest: pipe-B-plane-1
[292.008742] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[292.019932] Starting dynamic subtest: pipe-B-plane-2
[292.208363] Dynamic subtest pipe-B-plane-2: SUCCESS (0.199s)
[293.387106] Starting dynamic subtest: pipe-C-plane-0
[293.523684] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[293.533089] Starting dynamic subtest: pipe-C-plane-1
[293.668035] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[293.677845] Starting dynamic subtest: pipe-C-plane-2
[293.834684] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[295.023470] Starting dynamic subtest: pipe-D-plane-0
[295.185212] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[295.199079] Starting dynamic subtest: pipe-D-plane-1
[295.348579] Dynamic subtest pipe-D-plane-1: SUCCESS (0.165s)
[295.360788] Starting dynamic subtest: pipe-D-plane-2
[295.526988] Dynamic subtest pipe-D-plane-2: SUCCESS (0.177s)
[295.819285] Subtest plane-lut1d-lut1d: SUCCESS (5.950s)
[296.695453] [042/133] (720s left) prime_vgem (coherency-gtt)
[296.766898] Starting subtest: coherency-gtt
[296.771617] Subtest coherency-gtt: SKIP (0.000s)
[296.873743] [043/133] (720s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[296.969703] Starting subtest: 4-tiled-64bpp-rotate-90
[296.990099] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[297.119087] [044/133] (720s left) gem_vm_create (invalid-destroy)
[297.181676] Starting subtest: invalid-destroy
[297.183967] Subtest invalid-destroy: SUCCESS (0.002s)
[297.301385] [045/133] (720s left) kms_atomic_interruptible (legacy-pageflip)
[297.405447] Starting subtest: legacy-pageflip
[297.407794] Starting dynamic subtest: pipe-A-eDP-1
[304.805691] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.400s)
[304.808042] Subtest legacy-pageflip: SUCCESS (7.402s)
[305.658597] [046/133] (712s left) gem_exec_schedule (preempt-hang)
[305.841212] Starting subtest: preempt-hang
[305.843456] Starting dynamic subtest: rcs0
[306.066490] Dynamic subtest rcs0: SUCCESS (0.226s)
[306.076656] Starting dynamic subtest: bcs0
[306.292914] Dynamic subtest bcs0: SUCCESS (0.226s)
[306.301719] Starting dynamic subtest: vcs0
[306.511018] Dynamic subtest vcs0: SUCCESS (0.217s)
[306.521608] Starting dynamic subtest: vcs1
[306.727471] Dynamic subtest vcs1: SUCCESS (0.216s)
[306.738692] Starting dynamic subtest: vecs0
[306.949400] Dynamic subtest vecs0: SUCCESS (0.222s)
[306.961584] Starting dynamic subtest: ccs0
[307.181587] Dynamic subtest ccs0: SUCCESS (0.230s)
[307.183571] Subtest preempt-hang: SUCCESS (1.343s)
[308.397208] [047/133] (709s left) i915_query (hwconfig_table)
[308.462174] Starting subtest: hwconfig_table
[308.778692] Subtest hwconfig_table: SUCCESS (0.002s)
[308.817293] [048/133] (709s left) i915_drm_fdinfo (busy-check-all)
[308.859317] Starting subtest: busy-check-all
[308.861284] Starting dynamic subtest: rcs0
[308.867802] Dynamic subtest rcs0: SKIP (0.006s)
[308.877018] Starting dynamic subtest: bcs0
[308.881138] Dynamic subtest bcs0: SKIP (0.000s)
[308.889865] Starting dynamic subtest: vcs0
[308.893766] Dynamic subtest vcs0: SKIP (0.000s)
[308.902856] Starting dynamic subtest: vcs1
[308.907099] Dynamic subtest vcs1: SKIP (0.000s)
[308.915866] Starting dynamic subtest: vecs0
[308.920079] Dynamic subtest vecs0: SKIP (0.000s)
[308.929067] Starting dynamic subtest: ccs0
[308.933028] Dynamic subtest ccs0: SKIP (0.000s)
[308.936901] Subtest busy-check-all: SKIP (0.012s)
[308.974154] [049/133] (709s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[309.032962] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[309.141062] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[309.219656] [050/133] (708s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[309.333099] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[312.905655] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.575s)
[314.061596] [051/133] (703s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[314.117055] Starting subtest: etime-single-wait-available-unsubmitted
[314.220077] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s)
[314.297767] [052/133] (703s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[314.394809] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[314.400148] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[314.492577] [053/133] (703s left) syncobj_wait (multi-wait-submitted-signaled)
[314.553170] Starting subtest: multi-wait-submitted-signaled
[314.555385] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[314.659281] [054/133] (703s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[314.708646] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[314.783685] [055/133] (703s left) kms_psr (psr-cursor-plane-move)
[314.879211] Starting subtest: psr-cursor-plane-move
[314.881455] Starting dynamic subtest: eDP-1
[316.636454] Dynamic subtest eDP-1: SUCCESS (1.756s)
[316.638658] Subtest psr-cursor-plane-move: SUCCESS (1.758s)
[317.523096] [056/133] (700s left) gem_exec_balancer (nop)
[317.578085] Starting subtest: nop
[364.184264] Subtest nop: SUCCESS (46.604s)
[364.484069] [057/133] (653s left) kms_content_protection (srm)
[364.636059] Starting subtest: srm
[364.640469] Subtest srm: SKIP (0.003s)
[364.762131] [058/133] (653s left) kms_vblank (wait-forked-hang)
[364.853223] Starting subtest: wait-forked-hang
[364.855093] Starting dynamic subtest: pipe-A-eDP-1
[391.046329] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.193s)
[391.062988] Starting dynamic subtest: pipe-D-eDP-1
[416.062615] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.013s)
[416.064939] Subtest wait-forked-hang: SUCCESS (51.211s)
[416.887098] [059/133] (601s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[416.998593] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[417.002960] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[417.098661] [060/133] (601s left) gen9_exec_parse (batch-invalid-length)
[417.159655] Subtest batch-invalid-length: SKIP (0.000s)
[417.233498] [061/133] (601s left) i915_drm_fdinfo (virtual-idle)
[417.276626] Starting subtest: virtual-idle
[420.327418] Subtest virtual-idle: SUCCESS (3.052s)
[420.415979] [062/133] (598s left) core_hotunplug (unbind-rebind)
[420.502761] Starting subtest: unbind-rebind
[426.459109] Subtest unbind-rebind: SUCCESS (5.956s)
[426.504451] [063/133] (592s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[428.332359] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[437.204541] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.872s)
[437.330529] [064/133] (581s left) perf (low-oa-exponent-permissions)
[437.456823] Starting subtest: low-oa-exponent-permissions
[437.489020] Subtest low-oa-exponent-permissions: SUCCESS (0.033s)
[437.539266] [065/133] (581s left) kms_psr (pr-cursor-mmap-gtt)
[437.633189] Starting subtest: pr-cursor-mmap-gtt
[437.637678] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[437.705635] [066/133] (580s left) gem_userptr_blits (coherency-sync)
[437.775158] Starting subtest: coherency-sync
[438.108882] Subtest coherency-sync: SKIP (0.296s)
[438.223116] [067/133] (580s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[438.543619] Starting subtest: cursor-rapid-movement-512x170
[438.548077] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[438.695872] [068/133] (580s left) kms_flip (2x-absolute-wf_vblank)
[438.791249] Starting subtest: 2x-absolute-wf_vblank
[438.801137] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[438.880456] [069/133] (579s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[438.971289] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[438.973626] Starting dynamic subtest: pipe-A
[439.037040] Dynamic subtest pipe-A: SUCCESS (0.065s)
[439.047424] Starting dynamic subtest: pipe-B
[440.204841] Dynamic subtest pipe-B: SUCCESS (1.166s)
[440.216892] Starting dynamic subtest: pipe-C
[441.319376] Dynamic subtest pipe-C: SUCCESS (1.113s)
[441.329296] Starting dynamic subtest: pipe-D
[442.445065] Dynamic subtest pipe-D: SUCCESS (1.125s)
[442.447284] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.474s)
[443.608507] [070/133] (575s left) kms_chamelium_color (ctm-blue-to-red)
[443.709229] Subtest ctm-blue-to-red: SKIP (0.000s)
[443.763878] [071/133] (575s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[443.855611] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[443.859730] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[443.926679] [072/133] (575s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[444.028348] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[444.030643] Starting dynamic subtest: pipe-A-eDP-1
[444.039827] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[444.051603] Starting dynamic subtest: pipe-B-eDP-1
[444.060328] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[444.070072] Starting dynamic subtest: pipe-C-eDP-1
[444.078097] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[444.087262] Starting dynamic subtest: pipe-D-eDP-1
[444.095401] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[444.099269] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[446.271283] [073/133] (572s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[446.363626] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[446.367707] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[446.436041] [074/133] (572s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[446.531743] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[446.536149] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[446.604267] [075/133] (572s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[446.710369] Starting subtest: x-tiled-64bpp-rotate-90
[446.729732] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[446.842746] [076/133] (572s left) api_intel_allocator (reopen-fork)
[446.894692] Starting subtest: reopen-fork
[450.248771] Subtest reopen-fork: SUCCESS (3.355s)
[450.332259] [077/133] (568s left) gem_pread (self)
[450.390147] Subtest self: SKIP (0.000s)
[450.448932] [078/133] (568s left) kms_lease (lease-unleased-crtc)
[450.545708] Starting subtest: lease-unleased-crtc
[450.547826] Starting dynamic subtest: pipe-A-eDP-1
[450.848411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[450.859847] Starting dynamic subtest: pipe-B-eDP-1
[451.626046] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.776s)
[451.637971] Starting dynamic subtest: pipe-C-eDP-1
[451.640310] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[451.650118] Starting dynamic subtest: pipe-D-eDP-1
[451.652357] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[451.654524] Subtest lease-unleased-crtc: SUCCESS (1.090s)
[451.991479] [079/133] (567s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[452.095076] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[452.105051] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[452.204206] [080/133] (567s left) kms_psr (fbc-pr-primary-page-flip)
[452.304940] Starting subtest: fbc-pr-primary-page-flip
[452.309175] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[452.377960] [081/133] (566s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[452.506182] Starting subtest: y-tiled-64bpp-rotate-180
[452.510563] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[452.605458] [082/133] (566s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[452.711944] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[456.795458] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.087s)
[458.006832] [083/133] (561s left) gem_mmap_offset (isolation)
[458.068038] Starting subtest: isolation
[458.085294] Subtest isolation: SUCCESS (0.006s)
[458.175739] [084/133] (561s left) syncobj_timeline (wait-for-submit-complex)
[458.239400] Starting subtest: wait-for-submit-complex
[458.301981] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[458.377310] [085/133] (561s left) kms_chamelium_edid (hdmi-mode-timings)
[458.750757] Subtest hdmi-mode-timings: SKIP (0.000s)
[459.585744] [086/133] (559s left) kms_addfb_basic (unused-modifier)
[459.656730] Starting subtest: unused-modifier
[459.659106] Subtest unused-modifier: SUCCESS (0.000s)
[459.786925] [087/133] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[459.898517] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[459.902893] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[459.989462] [088/133] (559s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[460.082681] Starting subtest: yf-tiled-8bpp-rotate-180
[460.087058] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[460.209451] [089/133] (559s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[460.259171] Starting subtest: multi-wait-for-submit-available-submitted
[460.261417] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[460.385256] [090/133] (559s left) prime_vgem (basic-write)
[460.453191] Starting subtest: basic-write
[460.458609] Subtest basic-write: SKIP (0.006s)
[460.578539] [091/133] (559s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[460.673867] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[460.685245] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[460.760494] [092/133] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[460.864172] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[460.867460] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[460.982194] [093/133] (558s left) kms_panel_fitting (atomic-fastset)
[461.077734] Starting subtest: atomic-fastset
[461.079791] Starting dynamic subtest: pipe-A-eDP-1
[461.239459] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.164s)
[461.251524] Starting dynamic subtest: pipe-B-eDP-1
[462.461283] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.220s)
[462.474219] Starting dynamic subtest: pipe-C-eDP-1
[463.641858] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.179s)
[463.652249] Starting dynamic subtest: pipe-D-eDP-1
[464.779754] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[464.782073] Subtest atomic-fastset: SUCCESS (3.705s)
[465.929610] [094/133] (553s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[466.007517] Starting subtest: basic-batch-kernel-default-cmd
[466.011703] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[466.206435] [095/133] (553s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[466.312808] Starting subtest: fbc-rgb565-draw-mmap-cpu
[470.384394] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.075s)
[471.533056] [096/133] (548s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[471.638778] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[478.568358] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.933s)
[478.708831] [097/133] (541s left) kms_cursor_crc (cursor-onscreen-64x64)
[478.884090] Starting subtest: cursor-onscreen-64x64
[478.888891] Starting dynamic subtest: pipe-A-eDP-1
[480.994417] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.107s)
[481.025695] Starting dynamic subtest: pipe-D-eDP-1
[483.830263] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.812s)
[483.832407] Subtest cursor-onscreen-64x64: SUCCESS (4.944s)
[484.733130] [098/133] (535s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[484.836501] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[484.840839] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[484.937152] [099/133] (535s left) kms_cursor_crc (cursor-sliding-256x85)
[485.193689] Starting subtest: cursor-sliding-256x85
[485.239006] Subtest cursor-sliding-256x85: SKIP (0.041s)
[485.411411] [100/133] (534s left) perf (gen12-unprivileged-single-ctx-counters)
[485.527774] Starting subtest: gen12-unprivileged-single-ctx-counters
[485.530094] Starting dynamic subtest: rcs0
[485.828458] Dynamic subtest rcs0: SUCCESS (0.300s)
[485.830433] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.302s)
[485.879482] [101/133] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[485.996044] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[485.999600] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[486.088847] [102/133] (534s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[486.182729] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[486.186056] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[486.253254] [103/133] (533s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[486.338469] Starting subtest: addfb25-y-tiled-small-legacy
[486.341982] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[486.430055] [104/133] (533s left) gem_ctx_shared (create-shared-gtt)
[486.491329] Starting subtest: create-shared-gtt
[488.645051] Subtest create-shared-gtt: SUCCESS (2.151s)
[489.017382] [105/133] (531s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[489.108912] Starting subtest: fbc-psr2-sprite-mmap-gtt
[489.111223] Starting dynamic subtest: eDP-1
[489.115514] Dynamic subtest eDP-1: SKIP (0.000s)
[489.119888] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[489.184200] [106/133] (531s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[489.285779] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[489.290070] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[489.388976] [107/133] (531s left) syncobj_wait (multi-wait-for-submit-submitted)
[489.455032] Starting subtest: multi-wait-for-submit-submitted
[489.563486] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[489.642481] [108/133] (530s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[489.735352] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[489.739672] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[489.810823] [109/133] (530s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[489.868401] Starting subtest: multi-wait-all-available-submitted-signaled
[489.870780] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[489.991663] [110/133] (530s left) gem_render_copy (y-tiled-to-vebox-linear)
[490.042814] Starting subtest: y-tiled-to-vebox-linear
[490.046730] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[490.228153] [111/133] (530s left) prime_vgem (basic-fence-flip)
[490.297332] Starting subtest: basic-fence-flip
[490.597895] Subtest basic-fence-flip: SUCCESS (0.301s)
[490.705780] [112/133] (529s left) syncobj_timeline (wait-all-snapshot)
[490.751792] Starting subtest: wait-all-snapshot
[490.832043] Subtest wait-all-snapshot: SUCCESS (0.081s)
[490.924467] [113/133] (529s left) gem_softpin (evict-prime)
[490.986587] Starting subtest: evict-prime
[490.989040] Starting dynamic subtest: rcs0
[492.127639] Dynamic subtest rcs0: SUCCESS (1.140s)
[492.138704] Starting dynamic subtest: bcs0
[493.247628] Dynamic subtest bcs0: SUCCESS (1.119s)
[493.259509] Starting dynamic subtest: vcs0
[495.243202] Dynamic subtest vcs0: SUCCESS (1.993s)
[495.254303] Starting dynamic subtest: vcs1
[497.219152] Dynamic subtest vcs1: SUCCESS (1.974s)
[497.230191] Starting dynamic subtest: vecs0
[499.277272] Dynamic subtest vecs0: SUCCESS (2.055s)
[499.291097] Starting dynamic subtest: ccs0
[500.400600] Dynamic subtest ccs0: SUCCESS (1.122s)
[500.411297] Starting dynamic subtest: all
[502.274468] Dynamic subtest all: SUCCESS (1.871s)
[502.277205] Subtest evict-prime: SUCCESS (11.287s)
[502.360330] [114/133] (518s left) gem_caching (reads)
[502.436602] Subtest reads: SKIP (0.000s)
[502.519471] [115/133] (518s left) kms_tiled_display (basic-test-pattern)
[502.628811] Subtest basic-test-pattern: SKIP (0.000s)
[502.674809] [116/133] (518s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[502.772947] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[502.775111] Starting dynamic subtest: pipe-A-eDP-1
[535.454419] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.959s)
[535.465331] Starting dynamic subtest: pipe-B-eDP-1
[568.357612] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.682s)
[568.368859] Starting dynamic subtest: pipe-C-eDP-1
[601.363549] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.639s)
[601.375733] Starting dynamic subtest: pipe-D-eDP-1
[634.368550] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.665s)
[634.370934] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.950s)
[635.616178] [117/133] (385s left) kms_plane_alpha_blend (constant-alpha-max)
[635.720653] Starting subtest: constant-alpha-max
[636.003213] Starting dynamic subtest: pipe-A-eDP-1
[637.037161] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.031s)
[637.048593] Starting dynamic subtest: pipe-D-eDP-1
[638.655435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.613s)
[638.657716] Subtest constant-alpha-max: SUCCESS (2.932s)
[639.465093] [118/133] (381s left) perf_pmu (module-unload)