[60.532386] Initializing watchdogs
[60.532430]   /dev/watchdog0
[60.546030] [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]
[60.550671] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.552977] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.556637] [001/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[60.684851] Starting subtest: x-tiled-8bpp-rotate-180
[61.931262] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.247s)
[62.046632] [002/133] (959s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[62.142919] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[62.146285] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[62.208728] [003/133] (958s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[62.308583] Starting subtest: pr-cursor-plane-update-sf
[62.312288] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[62.373808] [004/133] (958s left) kms_frontbuffer_tracking (psr-slowdraw)
[62.469926] Starting subtest: psr-slowdraw
[87.715038] Subtest psr-slowdraw: SUCCESS (25.251s)
[87.831587] [005/133] (933s left) kms_flip (plain-flip-fb-recreate)
[87.935104] Starting subtest: plain-flip-fb-recreate
[87.937384] Starting dynamic subtest: A-eDP1
[96.820744] Dynamic subtest A-eDP1: SUCCESS (8.886s)
[96.828121] Starting dynamic subtest: B-eDP1
[105.670301] Dynamic subtest B-eDP1: SUCCESS (8.848s)
[105.680136] Starting dynamic subtest: C-eDP1
[114.489207] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[114.496179] Starting dynamic subtest: D-eDP1
[123.314910] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[123.321474] Subtest plain-flip-fb-recreate: SUCCESS (35.388s)
[124.505747] [006/133] (896s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[124.566712] Starting subtest: invalid-signal-one-illegal-handle
[124.569088] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[124.660359] [007/133] (896s left) api_intel_allocator (open-vm)
[124.715793] Starting subtest: open-vm
[124.718073] Subtest open-vm: SUCCESS (0.003s)
[124.824486] [008/133] (896s left) gem_exec_params (cliprects_ptr-dirt)
[124.880576] Starting subtest: cliprects_ptr-dirt
[124.882701] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[124.981194] [009/133] (896s left) gem_ctx_persistence (engines-hang)
[125.037761] Starting subtest: engines-hang
[125.039902] Starting dynamic subtest: rcs0
[125.082801] Dynamic subtest rcs0: SUCCESS (0.045s)
[125.091608] Starting dynamic subtest: bcs0
[125.203976] Dynamic subtest bcs0: SUCCESS (0.121s)
[125.214647] Starting dynamic subtest: vcs0
[125.273968] Dynamic subtest vcs0: SUCCESS (0.069s)
[125.283337] Starting dynamic subtest: vcs1
[125.391798] Dynamic subtest vcs1: SUCCESS (0.117s)
[125.403318] Starting dynamic subtest: vecs0
[125.462312] Dynamic subtest vecs0: SUCCESS (0.070s)
[125.470494] Starting dynamic subtest: ccs0
[125.573507] Dynamic subtest ccs0: SUCCESS (0.110s)
[125.575770] Subtest engines-hang: SUCCESS (0.536s)
[125.650740] [010/133] (895s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[125.737780] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[129.957609] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.221s)
[131.118299] [011/133] (890s left) kms_psr (fbc-psr2-primary-page-flip)
[131.216119] Starting subtest: fbc-psr2-primary-page-flip
[131.218242] Starting dynamic subtest: eDP-1
[131.222535] Dynamic subtest eDP-1: SKIP (0.000s)
[131.226795] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[131.284026] [012/133] (890s left) i915_drm_fdinfo (busy)
[131.319151] Starting subtest: busy
[131.321104] Starting dynamic subtest: rcs0
[131.339783] Dynamic subtest rcs0: SKIP (0.019s)
[131.348719] Starting dynamic subtest: bcs0
[131.352729] Dynamic subtest bcs0: SKIP (0.000s)
[131.359439] Starting dynamic subtest: vcs0
[131.363642] Dynamic subtest vcs0: SKIP (0.000s)
[131.370226] Starting dynamic subtest: vcs1
[131.374063] Dynamic subtest vcs1: SKIP (0.000s)
[131.380235] Starting dynamic subtest: vecs0
[131.384107] Dynamic subtest vecs0: SKIP (0.000s)
[131.390298] Starting dynamic subtest: ccs0
[131.394182] Dynamic subtest ccs0: SKIP (0.000s)
[131.398112] Subtest busy: SKIP (0.022s)
[131.430760] [013/133] (890s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[131.545738] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[131.550147] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[131.606952] [014/133] (889s left) kms_cursor_crc (cursor-offscreen-64x64)
[131.791753] Starting subtest: cursor-offscreen-64x64
[131.797048] Starting dynamic subtest: pipe-A-eDP-1
[133.743378] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.947s)
[133.770077] Starting dynamic subtest: pipe-D-eDP-1
[136.326737] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.560s)
[136.329440] Subtest cursor-offscreen-64x64: SUCCESS (4.532s)
[137.175288] [015/133] (884s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[137.269979] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[137.272254] Starting dynamic subtest: pipe-A-eDP-1
[137.292092] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[137.301369] Starting dynamic subtest: pipe-B-eDP-1
[137.320215] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[137.327247] Starting dynamic subtest: pipe-C-eDP-1
[137.345863] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[137.352640] Starting dynamic subtest: pipe-D-eDP-1
[137.373232] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[137.375445] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[139.544847] [016/133] (882s left) syncobj_timeline (single-wait-available-signaled)
[139.603988] Starting subtest: single-wait-available-signaled
[139.606431] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[139.696349] [017/133] (881s left) gem_tiled_fence_blits (normal)
[139.758219] Subtest normal: SKIP (0.000s)
[139.840353] [018/133] (881s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[139.934262] Starting subtest: 2x-flip-vs-modeset-vs-hang
[139.942344] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s)
[140.022813] [019/133] (881s left) syncobj_timeline (multi-wait-available-signaled)
[140.086189] Starting subtest: multi-wait-available-signaled
[140.088482] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[140.190938] [020/133] (881s left) kms_content_protection (uevent-hdcp14)
[140.322792] Starting subtest: uevent-hdcp14
[140.326916] Subtest uevent-hdcp14: SKIP (0.000s)
[140.445181] [021/133] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[140.544165] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[140.547751] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[140.650338] [022/133] (881s left) perf_pmu (semaphore-wait-idle)
[140.688903] Starting subtest: semaphore-wait-idle
[140.690803] Starting dynamic subtest: rcs0
[141.204089] Dynamic subtest rcs0: SUCCESS (0.512s)
[141.213873] Starting dynamic subtest: bcs0
[141.716972] Dynamic subtest bcs0: SUCCESS (0.512s)
[141.727864] Starting dynamic subtest: vcs0
[142.229695] Dynamic subtest vcs0: SUCCESS (0.511s)
[142.240625] Starting dynamic subtest: vcs1
[142.743030] Dynamic subtest vcs1: SUCCESS (0.512s)
[142.753752] Starting dynamic subtest: vecs0
[143.255800] Dynamic subtest vecs0: SUCCESS (0.511s)
[143.266693] Starting dynamic subtest: ccs0
[143.768756] Dynamic subtest ccs0: SUCCESS (0.512s)
[143.771558] Subtest semaphore-wait-idle: SUCCESS (3.078s)
[144.937757] [023/133] (876s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[145.038032] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[152.413823] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.379s)
[152.558173] [024/133] (869s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[152.654991] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[152.659141] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[152.725625] [025/133] (869s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[152.825857] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[152.830310] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[152.899624] [026/133] (869s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[152.960457] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[153.035589] [027/133] (868s left) kms_psr (pr-sprite-blt)
[153.130966] Starting subtest: pr-sprite-blt
[153.135550] Subtest pr-sprite-blt: SKIP (0.000s)
[153.212887] [028/133] (868s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[153.324677] Starting subtest: flip-vs-cursor-busy-crc-atomic
[154.131665] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.808s)
[155.004542] [029/133] (867s left) kms_psr (psr2-dpms)
[155.104798] Starting subtest: psr2-dpms
[155.107294] Starting dynamic subtest: eDP-1
[158.028550] Dynamic subtest eDP-1: SUCCESS (2.925s)
[158.030882] Subtest psr2-dpms: SUCCESS (2.926s)
[158.891816] [030/133] (863s left) syncobj_wait (single-wait-all-signaled)
[158.944153] Starting subtest: single-wait-all-signaled
[158.946492] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[159.044994] [031/133] (863s left) gem_render_copy_redux (interruptible)
[159.104982] Starting subtest: interruptible
[159.413833] Subtest interruptible: SUCCESS (0.310s)
[159.523950] [032/133] (862s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[159.622544] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[159.626965] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[159.700724] [033/133] (862s left) i915_pm_freq_api (freq-basic-api)
[159.753525] Starting subtest: freq-basic-api
[159.756035] Starting dynamic subtest: gt0
[159.758773] Dynamic subtest gt0: SUCCESS (0.003s)
[159.768205] Starting dynamic subtest: gt1
[159.770491] Dynamic subtest gt1: SUCCESS (0.003s)
[159.772663] Subtest freq-basic-api: SUCCESS (0.007s)
[159.847811] [034/133] (862s left) gem_exercise_blt (fast-copy)
[159.909993] Starting subtest: fast-copy
[159.911626] Starting dynamic subtest: linear-smem-smem
[159.937743] Dynamic subtest linear-smem-smem: SUCCESS (0.029s)
[159.945433] Starting dynamic subtest: xmajor-smem-smem
[159.955225] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[159.962296] Starting dynamic subtest: tile4-smem-smem
[159.972564] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[159.979283] Starting dynamic subtest: tile64-smem-smem
[159.989634] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[159.991541] Subtest fast-copy: SUCCESS (0.082s)
[160.125376] [035/133] (862s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[160.212126] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[160.215674] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[160.309318] [036/133] (862s left) gem_partial_pwrite_pread (reads-display)
[160.360710] Subtest reads-display: SKIP (0.000s)
[160.428241] [037/133] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[160.524955] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[160.528310] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[160.631794] [038/133] (861s left) gem_ctx_param (basic-default)
[160.697590] Starting subtest: basic-default
[160.699628] Subtest basic-default: SUCCESS (0.000s)
[160.770263] [039/133] (861s left) gem_exec_balancer (parallel)
[161.020656] Starting subtest: parallel
[161.924752] Subtest parallel: SUCCESS (0.904s)
[162.938487] [040/133] (859s left) gem_create (create-ext-set-pat)
[163.113548] Starting subtest: create-ext-set-pat
[163.116015] Subtest create-ext-set-pat: SUCCESS (0.001s)
[163.221961] [041/133] (859s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[163.330928] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[163.333140] Starting dynamic subtest: pipe-A-default-mode
[164.453505] Dynamic subtest pipe-A-default-mode: SKIP (1.119s)
[164.457999] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.120s)
[164.637024] [042/133] (857s left) gem_exec_reloc (basic-gtt-cpu-active)
[164.698646] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[164.761104] [043/133] (857s left) perf (rc6-disable)
[164.877436] Starting subtest: rc6-disable
[165.052703] Subtest rc6-disable: SUCCESS (0.176s)
[165.091458] [044/133] (857s left) gem_mmap_offset (clear-via-pagefault)
[165.157055] Starting subtest: clear-via-pagefault
[165.159300] Starting dynamic subtest: smem0
[204.515655] Dynamic subtest smem0: SUCCESS (39.354s)
[204.519235] Subtest clear-via-pagefault: SUCCESS (39.356s)
[204.659097] [045/133] (818s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[204.784393] Starting subtest: psr-dirtyfb-ioctl
[204.786302] Starting dynamic subtest: A-eDP-1
[208.744271] Dynamic subtest A-eDP-1: SUCCESS (3.959s)
[208.746436] Subtest psr-dirtyfb-ioctl: SUCCESS (3.960s)
[209.590875] [046/133] (813s left) kms_lease (lease-unleased-crtc)
[209.685551] Starting subtest: lease-unleased-crtc
[209.688021] Starting dynamic subtest: pipe-A-eDP-1
[209.974911] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[209.984881] Starting dynamic subtest: pipe-B-eDP-1
[210.750963] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.773s)
[210.763801] Starting dynamic subtest: pipe-C-eDP-1
[210.766052] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[210.774279] Starting dynamic subtest: pipe-D-eDP-1
[210.776432] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[210.778629] Subtest lease-unleased-crtc: SUCCESS (1.078s)
[211.137891] [047/133] (811s left) gem_render_copy (yf-tiled)
[211.202394] Starting subtest: yf-tiled
[211.206904] Subtest yf-tiled: SKIP (0.000s)
[211.378824] [048/133] (811s left) i915_suspend (sysfs-reader)
[211.442549] Starting subtest: sysfs-reader
[229.221622] Subtest sysfs-reader: SUCCESS (3.304s)
[229.260788] [049/133] (793s left) gem_render_linear_blits (basic)
[229.319335] Starting subtest: basic
[229.341858] Subtest basic: SUCCESS (0.023s)
[229.422939] [050/133] (793s left) gem_ctx_bad_destroy (invalid-pad)
[229.474254] Starting subtest: invalid-pad
[229.476275] Subtest invalid-pad: SUCCESS (0.000s)
[229.534252] [051/133] (793s left) gem_render_copy (y-tiled-ccs-to-linear)
[229.585373] Starting subtest: y-tiled-ccs-to-linear
[229.590291] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[229.774474] [052/133] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[229.878776] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[236.823936] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.954s)
[236.983814] [053/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[237.093501] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[243.722021] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.634s)
[243.844999] [054/133] (779s left) kms_cursor_edge_walk (128x128-right-edge)
[243.946063] Starting subtest: 128x128-right-edge
[243.948785] Starting dynamic subtest: pipe-A-eDP-1
[247.412498] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.468s)
[247.424753] Starting dynamic subtest: pipe-D-eDP-1
[250.541391] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[250.543752] Subtest 128x128-right-edge: SUCCESS (6.595s)
[251.335810] [055/133] (771s left) kms_plane (plane-position-hole-dpms)
[251.438441] Starting subtest: plane-position-hole-dpms
[251.946464] Starting dynamic subtest: pipe-A-plane-1
[254.331161] Dynamic subtest pipe-A-plane-1: SUCCESS (2.384s)
[254.341893] Starting dynamic subtest: pipe-A-plane-2
[256.681116] Dynamic subtest pipe-A-plane-2: SUCCESS (2.350s)
[256.692623] Starting dynamic subtest: pipe-A-plane-3
[259.040660] Dynamic subtest pipe-A-plane-3: SUCCESS (2.360s)
[259.051941] Starting dynamic subtest: pipe-A-plane-4
[261.429637] Dynamic subtest pipe-A-plane-4: SUCCESS (2.389s)
[261.440148] Starting dynamic subtest: pipe-A-plane-5
[261.457523] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[262.613914] Starting dynamic subtest: pipe-B-plane-1
[265.038014] Dynamic subtest pipe-B-plane-1: SUCCESS (2.432s)
[265.047382] Starting dynamic subtest: pipe-B-plane-2
[267.403906] Dynamic subtest pipe-B-plane-2: SUCCESS (2.366s)
[267.414404] Starting dynamic subtest: pipe-B-plane-3
[269.761092] Dynamic subtest pipe-B-plane-3: SUCCESS (2.357s)
[269.771563] Starting dynamic subtest: pipe-B-plane-4
[272.139563] Dynamic subtest pipe-B-plane-4: SUCCESS (2.376s)
[272.150356] Starting dynamic subtest: pipe-B-plane-5
[272.163524] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[272.165933] Subtest plane-position-hole-dpms: SUCCESS (20.727s)
[272.949617] [056/133] (750s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[273.061245] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[280.411396] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.359s)
[280.523506] [057/133] (742s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[280.625374] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[280.630437] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[280.713850] [058/133] (742s left) gem_softpin (full)
[280.764383] Starting subtest: full
[280.772700] Subtest full: SUCCESS (0.008s)
[280.887747] [059/133] (742s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[281.265290] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[282.062119] [060/133] (741s left) kms_dsc (dsc-fractional-bpp)
[282.157497] Starting subtest: dsc-fractional-bpp
[282.173348] Subtest dsc-fractional-bpp: SKIP (0.000s)
[282.228097] [061/133] (741s left) gem_exec_parallel (userptr)
[282.289664] Starting subtest: userptr
[282.292506] Starting dynamic subtest: rcs0
[283.991842] Dynamic subtest rcs0: SUCCESS (1.701s)
[284.002759] Starting dynamic subtest: bcs0
[285.690930] Dynamic subtest bcs0: SUCCESS (1.699s)
[285.700586] Starting dynamic subtest: vcs0
[287.345157] Dynamic subtest vcs0: SUCCESS (1.653s)
[287.368374] Starting dynamic subtest: vcs1
[289.317014] Dynamic subtest vcs1: SUCCESS (1.967s)
[289.329913] Starting dynamic subtest: vecs0
[291.364525] Dynamic subtest vecs0: SUCCESS (2.045s)
[291.377177] Starting dynamic subtest: ccs0
[293.177786] Dynamic subtest ccs0: SUCCESS (1.812s)
[293.180625] Subtest userptr: SUCCESS (10.890s)
[293.365160] [062/133] (730s left) gem_ctx_exec (basic)
[293.423603] Starting subtest: basic
[293.431327] Subtest basic: SUCCESS (0.009s)
[293.557735] [063/133] (729s left) gem_exec_schedule (submit-late-slice)
[293.632523] Starting subtest: submit-late-slice
[293.635088] Starting dynamic subtest: rcs0
[293.687138] Dynamic subtest rcs0: SUCCESS (0.063s)
[293.700264] Starting dynamic subtest: bcs0
[293.740831] Dynamic subtest bcs0: SUCCESS (0.053s)
[293.752652] Starting dynamic subtest: vcs0
[293.795363] Dynamic subtest vcs0: SUCCESS (0.054s)
[293.807520] Starting dynamic subtest: vcs1
[293.853189] Dynamic subtest vcs1: SUCCESS (0.057s)
[293.864787] Starting dynamic subtest: vecs0
[293.904958] Dynamic subtest vecs0: SUCCESS (0.051s)
[293.914865] Starting dynamic subtest: ccs0
[293.952275] Dynamic subtest ccs0: SUCCESS (0.046s)
[293.954905] Subtest submit-late-slice: SUCCESS (0.329s)
[295.490489] [064/133] (727s left) gem_exec_schedule (preempt-contexts)
[295.564440] Starting subtest: preempt-contexts
[295.567311] Starting dynamic subtest: rcs0
[295.684029] Dynamic subtest rcs0: SUCCESS (0.119s)
[295.695917] Starting dynamic subtest: bcs0
[295.784383] Dynamic subtest bcs0: SUCCESS (0.100s)
[295.794807] Starting dynamic subtest: vcs0
[295.854020] Dynamic subtest vcs0: SUCCESS (0.068s)
[295.865300] Starting dynamic subtest: vcs1
[295.920796] Dynamic subtest vcs1: SUCCESS (0.067s)
[295.931542] Starting dynamic subtest: vecs0
[295.996160] Dynamic subtest vecs0: SUCCESS (0.075s)
[296.006107] Starting dynamic subtest: ccs0
[296.080628] Dynamic subtest ccs0: SUCCESS (0.083s)
[296.083696] Subtest preempt-contexts: SUCCESS (0.517s)
[297.492156] [065/133] (726s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[297.543630] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[297.605876] [066/133] (725s left) gem_exec_reloc (basic-write-read-noreloc)
[297.673403] Subtest basic-write-read-noreloc: SKIP (0.000s)
[297.747169] [067/133] (725s left) kms_addfb_basic (master-rmfb)
[297.801149] Starting subtest: master-rmfb
[297.803235] Subtest master-rmfb: SUCCESS (0.001s)
[297.942507] [068/133] (725s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[298.042534] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[298.855210] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[299.015069] [069/133] (724s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[299.108638] Starting subtest: nonblocking-crc-frame-sequence
[299.111307] Starting dynamic subtest: pipe-A-eDP-1
[299.853513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[299.864737] Starting dynamic subtest: pipe-B-eDP-1
[301.298632] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s)
[301.310384] Starting dynamic subtest: pipe-C-eDP-1
[302.668176] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[302.678406] Starting dynamic subtest: pipe-D-eDP-1
[303.995560] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[303.998620] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.888s)
[304.798022] [070/133] (718s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[304.902443] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[304.907628] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[305.000678] [071/133] (718s left) kms_color (ctm-signed)
[305.085628] Starting subtest: ctm-signed
[305.088370] Starting dynamic subtest: pipe-A-eDP-1
[307.169196] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.085s)
[307.179485] Starting dynamic subtest: pipe-B-eDP-1
[310.034230] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.865s)
[310.043643] Starting dynamic subtest: pipe-C-eDP-1
[312.764575] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.729s)
[312.774233] Starting dynamic subtest: pipe-D-eDP-1
[315.436417] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.672s)
[315.439258] Subtest ctm-signed: SUCCESS (10.355s)
[316.256676] [072/133] (707s left) gem_exec_alignment (forked)
[316.321126] Starting subtest: forked
[354.347528] Subtest forked: SUCCESS (38.021s)
[354.429233] [073/133] (669s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[354.605796] Starting subtest: 4-tiled-32bpp-rotate-90
[354.626431] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[354.743646] [074/133] (669s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[354.850612] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[354.856445] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[354.931423] [075/133] (668s left) syncobj_wait (invalid-wait-bad-flags)
[354.996925] Starting subtest: invalid-wait-bad-flags
[354.999969] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[355.097363] [076/133] (668s left) sw_sync (sync_multi_timeline_wait)
[355.142353] Starting subtest: sync_multi_timeline_wait
[355.146990] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[355.191961] [077/133] (668s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[355.297152] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[355.301969] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[355.389799] [078/133] (668s left) gem_exec_fence (basic-busy)
[355.574398] Starting subtest: basic-busy
[355.577434] Starting dynamic subtest: rcs0
[355.651731] Dynamic subtest rcs0: SUCCESS (0.077s)
[355.662625] Starting dynamic subtest: bcs0
[355.714971] Dynamic subtest bcs0: SUCCESS (0.061s)
[355.727416] Starting dynamic subtest: vcs0
[355.776916] Dynamic subtest vcs0: SUCCESS (0.059s)
[355.790070] Starting dynamic subtest: vcs1
[355.831771] Dynamic subtest vcs1: SUCCESS (0.053s)
[355.844493] Starting dynamic subtest: vecs0
[355.887997] Dynamic subtest vecs0: SUCCESS (0.054s)
[355.902340] Starting dynamic subtest: ccs0
[355.943225] Dynamic subtest ccs0: SUCCESS (0.053s)
[355.946243] Subtest basic-busy: SUCCESS (0.371s)
[357.497364] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[357.502297] [079/133] (666s left) kms_async_flips (invalid-async-flip)
[357.598182] Starting subtest: invalid-async-flip
[357.974443] Starting dynamic subtest: pipe-A-eDP-1
[358.770884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.797s)
[359.136413] Starting dynamic subtest: pipe-B-eDP-1
[359.913397] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[360.277620] Starting dynamic subtest: pipe-C-eDP-1
[361.034277] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[361.391658] Starting dynamic subtest: pipe-D-eDP-1
[362.164392] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.782s)
[362.167257] Subtest invalid-async-flip: SUCCESS (4.569s)
[363.317320] [080/133] (660s left) kms_psr2_su (frontbuffer-xrgb8888)
[363.371442] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[363.426248] [081/133] (660s left) syncobj_timeline (etime-single-wait-submitted)
[363.484668] Starting subtest: etime-single-wait-submitted
[363.592683] Subtest etime-single-wait-submitted: SUCCESS (0.109s)
[363.685762] [082/133] (660s left) gem_exec_reloc (basic-cpu-wc-active)
[363.746646] Subtest basic-cpu-wc-active: SKIP (0.000s)
[363.825266] [083/133] (660s left) kms_flip (2x-flip-vs-panning-interruptible)
[363.930082] Starting subtest: 2x-flip-vs-panning-interruptible
[363.941488] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[364.016986] [084/133] (660s left) i915_pm_freq_mult (media-freq)
[364.066630] Starting subtest: media-freq
[364.069421] Starting dynamic subtest: gt0
[364.074482] Dynamic subtest gt0: SKIP (0.000s)
[364.088635] Starting dynamic subtest: gt1
[364.093482] Dynamic subtest gt1: SKIP (0.000s)
[364.098453] Subtest media-freq: SKIP (0.002s)
[364.159638] [085/133] (660s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[364.278764] Starting subtest: cursorA-vs-flipB-varying-size
[364.284679] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[364.419333] [086/133] (659s left) kms_pm_rpm (modeset-lpsp)
[366.579197] Starting subtest: modeset-lpsp
[368.051539] Subtest modeset-lpsp: SUCCESS (1.476s)
[368.140418] [087/133] (656s left) gem_exec_whisper (basic-fds-all)
[368.200875] Starting subtest: basic-fds-all
[378.491714] Subtest basic-fds-all: SUCCESS (10.288s)
[378.677939] [088/133] (645s left) fbdev (nullptr)
[378.715375] Starting subtest: nullptr
[378.717813] Subtest nullptr: SUCCESS (0.000s)
[378.776960] [089/133] (645s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[378.871418] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[385.926655] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.059s)
[386.057996] [090/133] (638s left) gem_userptr_blits (nohangcheck)
[386.133485] Starting subtest: nohangcheck
[386.383424] Subtest nohangcheck: SUCCESS (0.246s)
[386.521728] [091/133] (638s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[386.612383] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[386.614583] Starting dynamic subtest: pipe-A-eDP-1
[386.637347] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[386.649332] Starting dynamic subtest: pipe-B-eDP-1
[386.674361] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[386.684165] Starting dynamic subtest: pipe-C-eDP-1
[386.709638] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[386.719234] Starting dynamic subtest: pipe-D-eDP-1
[386.745508] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[386.751225] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[388.877380] [092/133] (635s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[389.295124] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[390.093167] [093/133] (634s left) perf (blocking)
[390.212363] Starting subtest: blocking
[390.214873] Starting dynamic subtest: 0-rcs0
[400.245599] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[400.257369] Starting dynamic subtest: 1-vcs0
[410.265466] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[410.268484] Subtest blocking: SUCCESS (20.054s)
[410.317679] [094/133] (614s left) kms_psr (psr-primary-mmap-gtt)
[410.416625] Starting subtest: psr-primary-mmap-gtt
[410.419076] Starting dynamic subtest: eDP-1
[411.914337] Dynamic subtest eDP-1: SKIP (1.494s)
[411.919671] Subtest psr-primary-mmap-gtt: SKIP (1.496s)
[412.080174] [095/133] (612s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[412.173581] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[412.176305] Starting dynamic subtest: pipe-A-eDP-1
[413.026777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.848s)
[413.038600] Starting dynamic subtest: pipe-B-eDP-1
[414.697061] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.665s)
[414.710224] Starting dynamic subtest: pipe-C-eDP-1
[416.192148] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.496s)
[416.203024] Starting dynamic subtest: pipe-D-eDP-1
[417.722623] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.529s)
[417.725412] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.543s)
[418.908402] [096/133] (605s left) gem_exec_params (no-vebox)
[418.984478] Starting subtest: no-vebox
[418.987109] Subtest no-vebox: SUCCESS (0.002s)
[420.442106] [097/133] (604s left) kms_pm_dc (dc5-psr)
[421.545541] Starting subtest: dc5-psr
[424.446892] Subtest dc5-psr: SUCCESS (2.901s)
[425.317456] [098/133] (599s left) gem_pread (self)
[425.378426] Subtest self: SKIP (0.000s)
[425.439658] [099/133] (599s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[425.537119] Starting subtest: yf-tiled-32bpp-rotate-90
[425.542557] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[425.635683] [100/133] (599s left) syncobj_eventfd (binary-wait)
[425.695520] Starting subtest: binary-wait
[425.704117] Subtest binary-wait: SUCCESS (0.011s)
[425.801833] [101/133] (599s left) kms_cursor_crc (cursor-size-hints)
[425.926649] Starting subtest: cursor-size-hints
[425.929343] Starting dynamic subtest: pipe-A-eDP-1
[426.543297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.615s)
[426.554305] Starting dynamic subtest: pipe-D-eDP-1
[427.787553] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[427.789932] Subtest cursor-size-hints: SUCCESS (1.860s)
[428.576139] [102/133] (596s left) kms_atomic_interruptible (legacy-cursor)
[428.671885] Starting subtest: legacy-cursor
[428.674094] Starting dynamic subtest: pipe-A-eDP-1
[436.088343] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.415s)
[436.090768] Subtest legacy-cursor: SUCCESS (7.416s)
[436.926455] [103/133] (588s left) gem_render_copy (x-tiled)
[436.978393] Starting subtest: x-tiled
[436.981033] Starting dynamic subtest: smem
[437.018631] Dynamic subtest smem: SUCCESS (0.040s)
[437.021519] Subtest x-tiled: SUCCESS (0.041s)
[437.243168] [104/133] (587s left) gen9_exec_parse (basic-rejected)
[437.305374] Subtest basic-rejected: SKIP (0.000s)
[437.376308] [105/133] (587s left) core_sysfs (read-all-entries)
[437.427914] Starting subtest: read-all-entries
[437.431891] Subtest read-all-entries: SUCCESS (0.007s)
[437.527042] [106/133] (587s left) perf (gen12-unprivileged-single-ctx-counters)
[437.647489] Starting subtest: gen12-unprivileged-single-ctx-counters
[437.650469] Starting dynamic subtest: rcs0
[437.692622] Dynamic subtest rcs0: SUCCESS (0.048s)
[437.695441] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.050s)
[437.745327] [107/133] (587s left) kms_big_fb (linear-32bpp-rotate-90)
[437.844351] Starting subtest: linear-32bpp-rotate-90
[437.864679] Subtest linear-32bpp-rotate-90: SKIP (0.020s)
[437.971349] [108/133] (587s left) gem_ctx_persistence (legacy-engines-hostile)
[438.034231] Starting subtest: legacy-engines-hostile
[438.036624] Starting dynamic subtest: render
[438.176601] Dynamic subtest render: SUCCESS (0.142s)
[438.191864] Starting dynamic subtest: bsd1
[438.272549] Dynamic subtest bsd1: SUCCESS (0.093s)
[438.287310] Starting dynamic subtest: bsd2
[438.377634] Dynamic subtest bsd2: SUCCESS (0.101s)
[438.392783] Starting dynamic subtest: blt
[438.421098] Dynamic subtest blt: SUCCESS (0.040s)
[438.431460] Starting dynamic subtest: vebox
[438.510638] Dynamic subtest vebox: SUCCESS (0.088s)
[438.513303] Subtest legacy-engines-hostile: SUCCESS (0.478s)
[438.590693] [109/133] (586s left) perf_pmu (enable-race)
[438.634512] Starting subtest: enable-race
[438.636611] Starting dynamic subtest: rcs0
[451.395390] Dynamic subtest rcs0: SUCCESS (12.764s)
[451.408741] Starting dynamic subtest: bcs0
[464.138650] Dynamic subtest bcs0: SUCCESS (12.739s)
[464.151857] Starting dynamic subtest: vcs0
[479.396636] Dynamic subtest vcs0: SUCCESS (15.252s)
[479.410292] Starting dynamic subtest: vcs1
[495.396921] Dynamic subtest vcs1: SUCCESS (15.996s)
[495.410912] Starting dynamic subtest: vecs0
[511.332121] Dynamic subtest vecs0: SUCCESS (15.932s)
[511.346466] Starting dynamic subtest: ccs0
[524.075684] Dynamic subtest ccs0: SUCCESS (12.741s)
[524.078709] Subtest enable-race: SUCCESS (85.438s)
[524.180096] [110/133] (501s left) gem_softpin (32b-excludes-last-page)
[524.240116] Starting subtest: 32b-excludes-last-page
[524.247178] Subtest 32b-excludes-last-page: SUCCESS (0.007s)
[524.362346] [111/133] (501s left) api_intel_bb (purge-bb)
[524.417072] Starting subtest: purge-bb
[524.424598] Subtest purge-bb: SUCCESS (0.008s)
[524.545209] [112/133] (500s left) kms_sequence (queue-idle)
[524.645456] Starting subtest: queue-idle
[524.648056] Starting dynamic subtest: pipe-A-eDP-1
[526.448892] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.804s)
[526.461023] Starting dynamic subtest: pipe-B-eDP-1
[528.902562] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.453s)
[528.914999] Starting dynamic subtest: pipe-C-eDP-1
[531.403267] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.499s)
[531.413962] Starting dynamic subtest: pipe-D-eDP-1
[533.847687] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.441s)
[533.850467] Subtest queue-idle: SUCCESS (9.201s)
[534.658106] [113/133] (490s left) gem_exec_flush (basic-wb-rw-before-default)
[534.729133] Starting subtest: basic-wb-rw-before-default
[540.191393] Subtest basic-wb-rw-before-default: SUCCESS (5.463s)
[540.381219] [114/133] (485s left) syncobj_timeline (wait-for-submit-delayed-submit)
[540.435466] Starting subtest: wait-for-submit-delayed-submit
[540.537914] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[540.633008] [115/133] (484s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[540.734775] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[540.740158] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[540.830150] [116/133] (484s left) kms_flip (flip-vs-panning-interruptible)
[540.924812] Starting subtest: flip-vs-panning-interruptible
[540.927349] Starting dynamic subtest: A-eDP1
[549.664257] Dynamic subtest A-eDP1: SUCCESS (8.739s)
[549.675057] Starting dynamic subtest: B-eDP1
[558.401322] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[558.414121] Starting dynamic subtest: C-eDP1
[567.123831] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[567.141000] Starting dynamic subtest: D-eDP1
[575.845156] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[575.850118] Subtest flip-vs-panning-interruptible: SUCCESS (34.927s)
[576.996694] [117/133] (448s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[577.092525] Starting subtest: y-tiled-16bpp-rotate-90
[577.098469] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[577.189310] [118/133] (448s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[577.277992] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[577.283478] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[577.391045] [119/133] (448s left) kms_plane_multiple (2x-tiling-4)
[577.478606] Starting subtest: 2x-tiling-4
[577.484025] Subtest 2x-tiling-4: SKIP (0.000s)
[577.553201] [120/133] (448s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[577.642798] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[577.645125] Starting dynamic subtest: pipe-A-eDP-1
[577.706130] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[577.717120] Starting dynamic subtest: pipe-B-eDP-1
[577.784393] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[577.797323] Starting dynamic subtest: pipe-C-eDP-1
[577.857533] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[577.866973] Starting dynamic subtest: pipe-D-eDP-1
[577.925416] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[577.929305] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[579.960365] [121/133] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[580.053773] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[580.058613] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[580.149917] [122/133] (445s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[580.251715] Starting subtest: fbcpsr-slowdraw
[605.455353] Subtest fbcpsr-slowdraw: SUCCESS (25.209s)
[605.602981] [123/133] (420s left) kms_invalid_mode (clock-too-high)
[605.700826] Starting subtest: clock-too-high
[605.703421] Starting dynamic subtest: pipe-A-eDP-1
[605.708420] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[605.719680] Starting dynamic subtest: pipe-B-eDP-1
[605.724458] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[605.734603] Starting dynamic subtest: pipe-C-eDP-1
[605.739821] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[605.749845] Starting dynamic subtest: pipe-D-eDP-1
[605.755041] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[605.760168] Subtest clock-too-high: SKIP (0.004s)
[605.799386] [124/133] (420s left) gem_exec_fence (submit)
[605.979908] Starting subtest: submit
[605.985517] Subtest submit: SKIP (0.000s)
[607.482111] [125/133] (418s left) kms_vblank (query-forked-busy-hang)
[607.565758] Starting subtest: query-forked-busy-hang
[607.568454] Starting dynamic subtest: pipe-A-eDP-1
[634.149590] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.586s)
[634.166923] Starting dynamic subtest: pipe-D-eDP-1
[659.175475] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s)
[659.178457] Subtest query-forked-busy-hang: SUCCESS (51.613s)
[660.010733] [126/133] (366s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[660.103324] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[660.108794] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[660.200855] [127/133] (365s left) gem_userptr_blits (dmabuf-unsync)
[660.269307] Subtest dmabuf-unsync: SKIP (0.000s)
[660.403141] [128/133] (365s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[660.495556] Starting subtest: plane-upscale-20x20-with-pixel-format
[660.498342] Starting dynamic subtest: pipe-A
[661.571233] Dynamic subtest pipe-A: SUCCESS (1.077s)
[661.582044] Starting dynamic subtest: pipe-B
[663.714116] Dynamic subtest pipe-B: SUCCESS (2.142s)
[663.724996] Starting dynamic subtest: pipe-C
[664.912188] Dynamic subtest pipe-C: SUCCESS (1.197s)
[664.923166] Starting dynamic subtest: pipe-D
[666.141543] Dynamic subtest pipe-D: SUCCESS (1.229s)
[666.144177] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.649s)
[667.366785] [129/133] (358s left) kms_chamelium_color (ctm-max)
[667.464333] Subtest ctm-max: SKIP (0.000s)
[667.513027] [130/133] (358s left) gem_render_copy (y-tiled)
[667.575153] Starting subtest: y-tiled
[667.580169] Subtest y-tiled: SKIP (0.000s)
[667.763268] [131/133] (358s left) kms_psr (fbc-psr-primary-mmap-gtt)
[667.850040] Starting subtest: fbc-psr-primary-mmap-gtt
[667.852343] Starting dynamic subtest: eDP-1
[667.857236] Dynamic subtest eDP-1: SKIP (0.000s)
[667.861776] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[667.925868] [132/133] (358s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[668.020449] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[668.026221] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[668.117185] [133/133] (358s left) gem_exec_params (secure-non-master)
[668.165491] Starting subtest: secure-non-master
[668.171075] Subtest secure-non-master: SKIP (0.000s)
[668.269682] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: gem_ctx_persistence
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_tiled_fence_blits
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_content_protection
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_fenced_exec_thrash
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_render_copy_redux
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_freq_api
results: parsing output: 33/ for test: gem_exercise_blt
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_partial_pwrite_pread
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_ctx_param
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: gem_create
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: kms_dirtyfb
results: parsing output: 45/ for test: kms_lease
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: i915_suspend
results: parsing output: 48/ for test: gem_render_linear_blits
results: parsing output: 49/ for test: gem_ctx_bad_destroy
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_softpin
results: parsing output: 58/ for test: kms_chamelium_edid
results: parsing output: 59/ for test: kms_dsc
results: parsing output: 60/ for test: gem_exec_parallel
results: parsing output: 61/ for test: gem_ctx_exec
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_pipe_crc_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: gem_exec_alignment
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: sw_sync
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_psr2_su
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: i915_pm_freq_mult
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: fbdev
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_chamelium_hpd
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_pm_dc
results: parsing output: 97/ for test: gem_pread
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: syncobj_eventfd
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_atomic_interruptible
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: gen9_exec_parse
results: parsing output: 104/ for test: core_sysfs
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: gem_softpin
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: kms_sequence
results: parsing output: 112/ for test: gem_exec_flush
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_plane_multiple
results: parsing output: 119/ for test: kms_ccs
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_invalid_mode
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_params
Done.