[61.500904] Initializing watchdogs
[61.500952]   /dev/watchdog0
[61.517638] [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]
[61.522245] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.524523] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.528062] [001/134] (960s left) gem_flink_basic (double-flink)
[61.610970] Starting subtest: double-flink
[61.613225] Subtest double-flink: SUCCESS (0.000s)
[61.717776] [002/134] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[61.813321] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[61.817806] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[61.930196] [003/134] (960s left) gem_pxp (regular-baseline-src-copy-readible)
[62.058991] Starting subtest: regular-baseline-src-copy-readible
[62.119260] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[62.271947] [004/134] (959s left) gem_create (create-size-update)
[62.333108] Starting subtest: create-size-update
[62.334733] Subtest create-size-update: SUCCESS (0.000s)
[62.545043] [005/134] (959s left) gem_mmap_gtt (close-race)
[62.607268] Subtest close-race: SKIP (0.000s)
[62.671034] [006/134] (959s left) syncobj_timeline (reset-signaled)
[62.729750] Starting subtest: reset-signaled
[62.732201] Subtest reset-signaled: SUCCESS (0.000s)
[62.847195] [007/134] (959s left) sw_sync (sync_multi_consumer)
[62.886182] Starting subtest: sync_multi_consumer
[63.318951] Subtest sync_multi_consumer: SUCCESS (0.432s)
[63.387276] [008/134] (958s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[63.488260] Starting subtest: fbc-rgb565-draw-mmap-gtt
[63.492956] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[63.594409] [009/134] (958s left) kms_cursor_crc (cursor-sliding-32x10)
[63.757882] Starting subtest: cursor-sliding-32x10
[63.811379] Subtest cursor-sliding-32x10: SKIP (0.050s)
[64.089989] [010/134] (958s left) kms_cursor_crc (cursor-onscreen-32x32)
[64.230745] Starting subtest: cursor-onscreen-32x32
[64.282092] Subtest cursor-onscreen-32x32: SKIP (0.049s)
[64.574632] [011/134] (957s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[64.682482] Starting subtest: psr-indfb-scaledprimary
[70.480881] Subtest psr-indfb-scaledprimary: SUCCESS (5.796s)
[70.625480] [012/134] (951s left) kms_pipe_crc_basic (bad-source)
[70.712859] Starting subtest: bad-source
[70.715244] Subtest bad-source: SUCCESS (0.000s)
[70.797420] [013/134] (951s left) kms_plane (plane-panning-bottom-right)
[70.890404] Starting subtest: plane-panning-bottom-right
[70.892843] Starting dynamic subtest: pipe-A
[72.606342] Dynamic subtest pipe-A: SUCCESS (1.710s)
[72.615193] Starting dynamic subtest: pipe-B
[75.046477] Dynamic subtest pipe-B: SUCCESS (2.440s)
[75.048803] Subtest plane-panning-bottom-right: SUCCESS (4.153s)
[75.888394] [014/134] (946s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[75.964776] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[75.967289] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[76.086735] [015/134] (946s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[76.190594] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[76.194942] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[76.326573] [016/134] (946s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[76.431799] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[76.434132] Starting dynamic subtest: pipe-A-eDP-1
[76.456103] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[76.466523] Starting dynamic subtest: pipe-B-eDP-1
[76.487615] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[76.497728] Starting dynamic subtest: pipe-C-eDP-1
[76.519788] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[76.528652] Starting dynamic subtest: pipe-D-eDP-1
[76.550732] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[76.555159] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[78.721647] [017/134] (943s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[78.821032] Starting subtest: basic-max-pipe-crc-check
[78.825719] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[78.863653] [018/134] (943s left) gem_exec_reloc (basic-cpu)
[78.916787] Subtest basic-cpu: SKIP (0.000s)
[78.992100] [019/134] (943s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[79.087079] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[79.089470] Starting dynamic subtest: pipe-A-eDP-1
[79.114571] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[79.122743] Starting dynamic subtest: pipe-B-eDP-1
[79.144428] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[79.151333] Starting dynamic subtest: pipe-C-eDP-1
[79.173208] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[79.179689] Starting dynamic subtest: pipe-D-eDP-1
[79.201622] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.205964] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[81.393188] [020/134] (941s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[81.779859] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[82.606381] [021/134] (940s left) gem_ctx_persistence (legacy-engines-hostile)
[82.677074] Starting subtest: legacy-engines-hostile
[82.679043] Starting dynamic subtest: render
[82.781033] Dynamic subtest render: SUCCESS (0.106s)
[82.791505] Starting dynamic subtest: bsd1
[82.891329] Dynamic subtest bsd1: SUCCESS (0.109s)
[82.901225] Starting dynamic subtest: bsd2
[83.000587] Dynamic subtest bsd2: SUCCESS (0.107s)
[83.010918] Starting dynamic subtest: blt
[83.117323] Dynamic subtest blt: SUCCESS (0.116s)
[83.127094] Starting dynamic subtest: vebox
[83.255918] Dynamic subtest vebox: SUCCESS (0.136s)
[83.258788] Subtest legacy-engines-hostile: SUCCESS (0.582s)
[83.345516] [022/134] (939s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[83.445871] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[83.448184] Starting dynamic subtest: pipe-A-eDP-1
[83.471428] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.480817] Starting dynamic subtest: pipe-B-eDP-1
[83.502283] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.509620] Starting dynamic subtest: pipe-C-eDP-1
[83.531702] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.540111] Starting dynamic subtest: pipe-D-eDP-1
[83.560384] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.563807] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[85.673113] [023/134] (937s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[85.759231] Starting subtest: plane-upscale-20x20-with-rotation
[85.761523] Starting dynamic subtest: pipe-A
[85.985676] Dynamic subtest pipe-A: SUCCESS (0.226s)
[85.994351] Starting dynamic subtest: pipe-B
[87.236811] Dynamic subtest pipe-B: SUCCESS (1.250s)
[87.245724] Starting dynamic subtest: pipe-C
[88.574336] Dynamic subtest pipe-C: SUCCESS (1.337s)
[88.583989] Starting dynamic subtest: pipe-D
[89.902443] Dynamic subtest pipe-D: SUCCESS (1.327s)
[89.904832] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.143s)
[91.091997] [024/134] (931s left) gem_exec_fence (syncobj-wait)
[91.541370] Starting subtest: syncobj-wait
[92.934875] Subtest syncobj-wait: SUCCESS (1.392s)
[93.285142] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[93.288143] [025/134] (929s left) gem_exec_fence (keep-in-fence)
[93.466066] Starting subtest: keep-in-fence
[93.468386] Starting dynamic subtest: rcs0
[93.555954] Dynamic subtest rcs0: SUCCESS (0.089s)
[93.564326] Starting dynamic subtest: bcs0
[93.612182] Dynamic subtest bcs0: SUCCESS (0.055s)
[93.622236] Starting dynamic subtest: vcs0
[94.935880] Dynamic subtest vcs0: SUCCESS (1.321s)
[94.945924] Starting dynamic subtest: vcs1
[96.919998] Dynamic subtest vcs1: SUCCESS (1.982s)
[96.928791] Starting dynamic subtest: vecs0
[98.905065] Dynamic subtest vecs0: SUCCESS (1.983s)
[98.915747] Starting dynamic subtest: ccs0
[99.134955] Dynamic subtest ccs0: SUCCESS (0.230s)
[99.137599] Subtest keep-in-fence: SUCCESS (5.668s)
[100.959515] [026/134] (922s left) gem_exec_reloc (basic-wc-read)
[101.030185] Subtest basic-wc-read: SKIP (0.000s)
[101.116212] [027/134] (921s left) kms_content_protection (content-type-change)
[101.262068] Starting subtest: content-type-change
[101.266641] Subtest content-type-change: SKIP (0.000s)
[101.438748] [028/134] (921s left) gem_exec_schedule (preemptive-hang)
[101.624956] Starting subtest: preemptive-hang
[101.627367] Starting dynamic subtest: rcs0
[111.046076] Dynamic subtest rcs0: SUCCESS (9.421s)
[111.055695] Starting dynamic subtest: bcs0
[119.998887] Dynamic subtest bcs0: SUCCESS (8.952s)
[120.011462] Starting dynamic subtest: vcs0
[129.023737] Dynamic subtest vcs0: SUCCESS (9.023s)
[129.033444] Starting dynamic subtest: vcs1
[138.046666] Dynamic subtest vcs1: SUCCESS (9.024s)
[138.054085] Starting dynamic subtest: vecs0
[147.004637] Dynamic subtest vecs0: SUCCESS (8.956s)
[147.011903] Starting dynamic subtest: ccs0
[156.035857] Dynamic subtest ccs0: SUCCESS (9.032s)
[156.038283] Subtest preemptive-hang: SUCCESS (54.412s)
[156.314699] [029/134] (866s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[156.414768] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[156.417052] Starting dynamic subtest: pipe-A-default-mode
[159.150615] Dynamic subtest pipe-A-default-mode: SUCCESS (2.735s)
[159.152966] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.736s)
[159.996071] [030/134] (863s left) syncobj_timeline (wait-for-submit-snapshot)
[160.059067] Starting subtest: wait-for-submit-snapshot
[160.140372] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[160.240738] [031/134] (862s left) syncobj_wait (single-wait-all-submitted)
[160.307906] Starting subtest: single-wait-all-submitted
[160.410998] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[160.509648] [032/134] (862s left) gen9_exec_parse (unaligned-access)
[160.566762] Subtest unaligned-access: SKIP (0.000s)
[160.656143] [033/134] (862s left) gem_userptr_blits (unsync-overlap)
[160.735312] Subtest unsync-overlap: SKIP (0.000s)
[160.900063] [034/134] (862s left) kms_flip (dpms-vs-vblank-race-interruptible)
[161.000520] Starting subtest: dpms-vs-vblank-race-interruptible
[161.002757] Starting dynamic subtest: A-eDP1
[165.991450] Dynamic subtest A-eDP1: SUCCESS (4.987s)
[166.000262] Starting dynamic subtest: B-eDP1
[170.613303] Dynamic subtest B-eDP1: SUCCESS (4.619s)
[170.621682] Starting dynamic subtest: C-eDP1
[174.126219] Dynamic subtest C-eDP1: SUCCESS (3.514s)
[174.136530] Starting dynamic subtest: D-eDP1
[178.757245] Dynamic subtest D-eDP1: SUCCESS (4.629s)
[178.759472] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.756s)
[179.643277] [035/134] (843s left) kms_vblank (wait-busy)
[179.738679] Starting subtest: wait-busy
[179.740939] Starting dynamic subtest: pipe-A-eDP-1
[181.614584] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[181.627845] Starting dynamic subtest: pipe-D-eDP-1
[184.196319] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.580s)
[184.198600] Subtest wait-busy: SUCCESS (4.458s)
[185.001169] [036/134] (838s left) gen9_exec_parse (bb-start-out)
[185.070604] Subtest bb-start-out: SKIP (0.000s)
[185.149857] [037/134] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[185.253611] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[185.257602] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[185.366338] [038/134] (838s left) i915_hangman (gt-engine-error)
[185.436028] Starting subtest: gt-engine-error
[185.437861] Starting dynamic subtest: rcs0
[186.869354] Dynamic subtest rcs0: SUCCESS (1.432s)
[186.879837] Starting dynamic subtest: bcs0
[188.852831] Dynamic subtest bcs0: SUCCESS (1.981s)
[188.863635] Starting dynamic subtest: vcs0
[190.902519] Dynamic subtest vcs0: SUCCESS (2.047s)
[190.913075] Starting dynamic subtest: vcs1
[192.885424] Dynamic subtest vcs1: SUCCESS (1.981s)
[192.896380] Starting dynamic subtest: vecs0
[194.869033] Dynamic subtest vecs0: SUCCESS (1.982s)
[194.879780] Starting dynamic subtest: ccs0
[196.852886] Dynamic subtest ccs0: SUCCESS (1.982s)
[196.855642] Subtest gt-engine-error: SUCCESS (11.417s)
[196.951432] [039/134] (826s left) perf (gen12-group-exclusive-stream-ctx-handle)
[197.084456] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[197.110332] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s)
[197.149335] [040/134] (826s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[198.955448] Starting subtest: 4-tiled-16bpp-rotate-270
[198.974735] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[199.133340] [041/134] (824s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[199.237982] Starting subtest: fbcpsr-suspend
[239.651483] Subtest fbcpsr-suspend: SUCCESS (10.226s)
[239.824189] [042/134] (783s left) i915_suspend (fence-restore-tiled2untiled)
[239.894301] Starting subtest: fence-restore-tiled2untiled
[239.898580] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[240.028001] [043/134] (783s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[240.089130] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[240.197047] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[240.300457] [044/134] (783s left) prime_self_import (basic-with_one_bo_two_files)
[240.331752] Starting subtest: basic-with_one_bo_two_files
[240.364417] Subtest basic-with_one_bo_two_files: SUCCESS (0.034s)
[240.499888] [045/134] (783s left) kms_pm_rpm (legacy-planes)
[242.234908] Starting subtest: legacy-planes
[242.237264] Starting dynamic subtest: plane-64
[250.573731] Dynamic subtest plane-64: SUCCESS (8.298s)
[250.582962] Starting dynamic subtest: plane-94
[258.889637] Dynamic subtest plane-94: SUCCESS (8.297s)
[258.898703] Starting dynamic subtest: plane-124
[267.179023] Dynamic subtest plane-124: SUCCESS (8.279s)
[267.189927] Starting dynamic subtest: plane-134
[275.476767] Dynamic subtest plane-134: SUCCESS (8.299s)
[275.479660] Subtest legacy-planes: SUCCESS (33.180s)
[275.870003] [046/134] (747s left) gem_mmap_gtt (fault-concurrent-y)
[275.931501] Subtest fault-concurrent-Y: SKIP (0.000s)
[276.002643] [047/134] (747s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[276.127289] Starting subtest: basic-busy-flip-before-cursor-atomic
[276.131829] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[276.296096] [048/134] (747s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[276.404089] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[282.948269] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.548s)
[283.087095] [049/134] (740s left) kms_psr (pr-sprite-blt)
[283.191166] Starting subtest: pr-sprite-blt
[283.195633] Subtest pr-sprite-blt: SKIP (0.000s)
[283.275220] [050/134] (740s left) kms_plane_multiple (tiling-y)
[283.377863] Starting subtest: tiling-y
[283.382238] Subtest tiling-y: SKIP (0.000s)
[283.463544] [051/134] (740s left) gem_exec_params (rel-constants-invalid)
[283.519731] Starting subtest: rel-constants-invalid
[283.522090] Subtest rel-constants-invalid: SUCCESS (0.000s)
[283.647164] [052/134] (740s left) dmabuf_sync_file (export-basic)
[283.685162] Starting subtest: export-basic
[283.687294] Subtest export-basic: SUCCESS (0.001s)
[283.760004] [053/134] (740s left) gem_madvise (dontneed-before-mmap)
[283.799593] Starting subtest: dontneed-before-mmap
[283.824759] Subtest dontneed-before-mmap: SUCCESS (0.028s)
[283.948606] [054/134] (740s left) kms_flip (2x-blocking-absolute-wf_vblank)
[284.047870] Starting subtest: 2x-blocking-absolute-wf_vblank
[284.057629] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[284.196508] [055/134] (740s left) kms_psr (fbc-psr-primary-mmap-gtt)
[284.278290] Starting subtest: fbc-psr-primary-mmap-gtt
[284.280146] Starting dynamic subtest: eDP-1
[284.283470] Dynamic subtest eDP-1: SKIP (0.000s)
[284.286831] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[284.361572] [056/134] (739s left) kms_fbcon_fbt (psr-suspend)
[284.419347] Starting subtest: psr-suspend
[333.975585] Subtest psr-suspend: SUCCESS (19.503s)
[334.078615] [057/134] (690s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[334.182880] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[334.209173] Starting dynamic subtest: pipe-A-plane-0
[334.214147] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[334.223899] Starting dynamic subtest: pipe-A-plane-3
[334.228421] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[334.237073] Starting dynamic subtest: pipe-A-plane-5
[334.241662] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[335.312139] Starting dynamic subtest: pipe-B-plane-0
[335.317833] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[335.329109] Starting dynamic subtest: pipe-B-plane-3
[335.334269] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[335.342965] Starting dynamic subtest: pipe-B-plane-5
[335.348210] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[335.612361] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (1.415s)
[336.493942] [058/134] (687s left) api_intel_bb (object-noreloc-purge-cache-simple)
[336.558850] Starting subtest: object-noreloc-purge-cache-simple
[336.562333] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s)
[336.716943] [059/134] (687s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[336.816792] Starting subtest: psr-dirtyfb-ioctl
[336.819531] Starting dynamic subtest: A-eDP-1
[340.724918] Dynamic subtest A-eDP-1: SUCCESS (3.889s)
[340.727567] Subtest psr-dirtyfb-ioctl: SUCCESS (3.891s)
[341.532456] [060/134] (682s left) kms_flip (flip-vs-panning-vs-hang)
[341.623243] Starting subtest: flip-vs-panning-vs-hang
[341.625738] Starting dynamic subtest: A-eDP1
[392.452516] Dynamic subtest A-eDP1: SUCCESS (50.797s)
[392.463004] Starting dynamic subtest: D-eDP1
[432.449103] Dynamic subtest D-eDP1: SUCCESS (39.985s)
[432.451866] Subtest flip-vs-panning-vs-hang: SUCCESS (90.786s)
[433.682962] [061/134] (590s left) kms_big_fb (linear-64bpp-rotate-270)
[433.837279] Starting subtest: linear-64bpp-rotate-270
[433.867298] Subtest linear-64bpp-rotate-270: SKIP (0.028s)
[434.012984] [062/134] (590s left) gem_mmap_wc (copy)
[434.080398] Subtest copy: SKIP (0.000s)
[434.153686] [063/134] (590s left) kms_flip (flip-vs-absolute-wf_vblank)
[434.249653] Starting subtest: flip-vs-absolute-wf_vblank
[434.252364] Starting dynamic subtest: A-eDP1
[443.220151] Dynamic subtest A-eDP1: SUCCESS (8.972s)
[443.231965] Starting dynamic subtest: B-eDP1
[452.153165] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[452.164787] Starting dynamic subtest: C-eDP1
[461.069380] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[461.081739] Starting dynamic subtest: D-eDP1
[470.004171] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[470.009734] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.762s)
[471.240787] [064/134] (553s left) gem_exec_nop (basic-sequential)
[471.328361] Starting subtest: basic-sequential
[486.420413] Subtest basic-sequential: SUCCESS (15.104s)
[486.661927] [065/134] (537s left) gem_workarounds (suspend-resume)
[486.742785] Starting subtest: suspend-resume
[503.002719] Subtest suspend-resume: SUCCESS (1.240s)
[503.168917] [066/134] (521s left) gem_exec_reloc (basic-cpu-gtt-active)
[503.230829] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[503.308962] [067/134] (521s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[503.410237] Starting subtest: yf-tiled-8bpp-rotate-270
[503.414797] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[503.536078] [068/134] (521s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[503.624451] Starting subtest: fbc-rgb101010-draw-pwrite
[508.986772] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.298s)
[510.178312] [069/134] (514s left) gem_softpin (allocator-basic)
[510.240658] Starting subtest: allocator-basic
[510.320334] Subtest allocator-basic: SUCCESS (0.078s)
[510.490513] [070/134] (514s left) syncobj_basic (bad-fd-to-handle)
[510.550692] Starting subtest: bad-fd-to-handle
[510.552887] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[510.673823] [071/134] (514s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[510.766467] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[510.770783] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[510.886575] [072/134] (514s left) gem_fenced_exec_thrash (2-spare-fences)
[510.953312] Subtest 2-spare-fences: SKIP (0.000s)
[511.035249] [073/134] (513s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[511.133810] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[511.137522] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[511.252809] [074/134] (513s left) gem_partial_pwrite_pread (reads)
[511.304287] Subtest reads: SKIP (0.000s)
[511.385234] [075/134] (513s left) kms_properties (invalid-properties-atomic)
[511.476703] Starting subtest: invalid-properties-atomic
[511.783108] Subtest invalid-properties-atomic: SUCCESS (0.304s)
[511.878957] [076/134] (513s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[516.957573] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[516.962198] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.003s)
[517.817798] [077/134] (507s left) i915_pm_rps (reset)
[517.885881] Starting subtest: reset
[526.363191] Subtest reset: SUCCESS (8.460s)
[526.520350] [078/134] (498s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[526.581444] Starting subtest: multi-wait-all-available-submitted-signaled
[526.583752] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[526.704666] [079/134] (498s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[526.816802] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[526.820941] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[526.916678] [080/134] (498s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[527.016956] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[527.021235] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[527.145974] [081/134] (498s left) gem_exec_balancer (hang)
[527.414320] Starting subtest: hang
[529.081897] Subtest hang: SUCCESS (1.670s)
[529.243060] [082/134] (496s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[529.345546] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[529.347861] Starting dynamic subtest: A-eDP1
[532.953797] Dynamic subtest A-eDP1: SUCCESS (3.602s)
[532.967285] Starting dynamic subtest: B-eDP1
[536.164887] Dynamic subtest B-eDP1: SUCCESS (3.207s)
[536.175061] Starting dynamic subtest: C-eDP1
[539.285584] Dynamic subtest C-eDP1: SUCCESS (3.118s)
[539.295339] Starting dynamic subtest: D-eDP1
[542.362146] Dynamic subtest D-eDP1: SUCCESS (3.076s)
[542.364538] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.012s)
[543.193926] [083/134] (482s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[543.320930] Starting subtest: yf-tiled-16bpp-rotate-0
[543.325542] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[543.463129] [084/134] (481s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[543.560475] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[543.564842] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[543.671831] [085/134] (481s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[543.772371] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[543.776356] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[543.895497] [086/134] (481s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[543.985139] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[543.987362] Starting dynamic subtest: pipe-A-default-mode
[544.294575] Dynamic subtest pipe-A-default-mode: SKIP (0.308s)
[544.299029] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.310s)
[545.105966] [087/134] (480s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[550.056816] Starting subtest: fbc-pr-cursor-plane-update-sf
[550.061155] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.003s)
[550.922585] [088/134] (474s left) gem_exec_await (wide-contexts)
[551.152754] Starting subtest: wide-contexts
[574.880549] Subtest wide-contexts: SUCCESS (23.718s)
[575.089361] [089/134] (450s left) perf_pmu (most-busy-idle-check-all)
[575.173602] Starting subtest: most-busy-idle-check-all
[575.176066] Starting dynamic subtest: rcs0
[576.965825] Dynamic subtest rcs0: SUCCESS (1.789s)
[576.979230] Starting dynamic subtest: bcs0
[578.949664] Dynamic subtest bcs0: SUCCESS (1.980s)
[578.962940] Starting dynamic subtest: vcs0
[580.933827] Dynamic subtest vcs0: SUCCESS (1.980s)
[580.949236] Starting dynamic subtest: vcs1
[582.981824] Dynamic subtest vcs1: SUCCESS (2.042s)
[582.994535] Starting dynamic subtest: vecs0
[584.965771] Dynamic subtest vecs0: SUCCESS (1.980s)
[584.978434] Starting dynamic subtest: ccs0
[586.949294] Dynamic subtest ccs0: SUCCESS (1.980s)
[586.952127] Subtest most-busy-idle-check-all: SUCCESS (11.771s)
[587.070654] [090/134] (438s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[587.195991] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[587.200421] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[587.332602] [091/134] (438s left) kms_scaling_modes (scaling-mode-full-aspect)
[587.424283] Starting subtest: scaling-mode-full-aspect
[587.426674] Starting dynamic subtest: pipe-A-eDP-1
[587.523242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.101s)
[587.534107] Starting dynamic subtest: pipe-B-eDP-1
[588.738494] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.213s)
[588.749737] Starting dynamic subtest: pipe-C-eDP-1
[589.850643] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[589.860816] Starting dynamic subtest: pipe-D-eDP-1
[590.980318] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[590.982562] Subtest scaling-mode-full-aspect: SUCCESS (3.557s)
[592.246911] [092/134] (433s left) kms_psr (fbc-pr-basic)
[592.349145] Starting subtest: fbc-pr-basic
[592.353481] Subtest fbc-pr-basic: SKIP (0.000s)
[592.436309] [093/134] (433s left) kms_psr (psr2-sprite-mmap-cpu)
[592.531031] Starting subtest: psr2-sprite-mmap-cpu
[592.533262] Starting dynamic subtest: eDP-1
[594.235639] Dynamic subtest eDP-1: SUCCESS (1.702s)
[594.237929] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.703s)
[595.118351] [094/134] (430s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[595.208933] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[595.211167] Starting dynamic subtest: pipe-A-eDP-1
[595.235767] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[595.247833] Starting dynamic subtest: pipe-B-eDP-1
[595.271475] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[595.280763] Starting dynamic subtest: pipe-C-eDP-1
[595.304337] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[595.313883] Starting dynamic subtest: pipe-D-eDP-1
[595.337771] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[595.342228] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[597.485689] [095/134] (428s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[597.563880] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[597.653159] [096/134] (428s left) gem_ctx_sseu (invalid-args)
[597.720223] Subtest invalid-args: SKIP (0.000s)
[597.785486] [097/134] (428s left) kms_prop_blob (blob-multiple)
[597.847278] Starting subtest: blob-multiple
[597.849562] Subtest blob-multiple: SUCCESS (0.002s)
[597.980952] [098/134] (428s left) gem_exec_schedule (thriceslice)
[598.075190] Starting subtest: thriceslice
[598.077550] Starting dynamic subtest: rcs0
[598.095948] Dynamic subtest rcs0: SUCCESS (0.029s)
[598.108159] Starting dynamic subtest: bcs0
[598.147703] Dynamic subtest bcs0: SUCCESS (0.050s)
[598.161850] Starting dynamic subtest: vcs0
[598.178507] Dynamic subtest vcs0: SUCCESS (0.029s)
[598.188122] Starting dynamic subtest: vcs1
[598.206539] Dynamic subtest vcs1: SUCCESS (0.027s)
[598.218328] Starting dynamic subtest: vecs0
[598.236241] Dynamic subtest vecs0: SUCCESS (0.029s)
[598.250053] Starting dynamic subtest: ccs0
[598.289623] Dynamic subtest ccs0: SUCCESS (0.053s)
[598.292054] Subtest thriceslice: SUCCESS (0.224s)
[598.602932] [099/134] (427s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[598.700470] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[598.704796] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[598.833483] [100/134] (427s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[598.949215] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[598.953631] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[599.076837] [101/134] (427s left) gem_exec_capture (pi)
[599.144712] Starting subtest: pi
[599.147133] Starting dynamic subtest: rcs0
[603.438477] Dynamic subtest rcs0: SUCCESS (4.299s)
[603.451510] Starting dynamic subtest: bcs0
[607.686720] Dynamic subtest bcs0: SUCCESS (4.246s)
[607.699032] Starting dynamic subtest: vcs0
[611.849493] Dynamic subtest vcs0: SUCCESS (4.161s)
[611.862208] Starting dynamic subtest: vcs1
[616.015318] Dynamic subtest vcs1: SUCCESS (4.165s)
[616.026283] Starting dynamic subtest: vecs0
[620.177242] Dynamic subtest vecs0: SUCCESS (4.160s)
[620.189944] Starting dynamic subtest: ccs0
[624.393573] Dynamic subtest ccs0: SUCCESS (4.214s)
[624.396274] Subtest pi: SUCCESS (25.260s)
[624.486658] [102/134] (401s left) gem_ctx_param (invalid-get-no-zeromap)
[624.586877] Starting subtest: invalid-get-no-zeromap
[624.589295] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[624.718303] [103/134] (401s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[624.831379] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[624.833711] Starting dynamic subtest: pipe-A-default-mode
[625.127365] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[625.131962] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.294s)
[626.002786] [104/134] (400s left) kms_feature_discovery (dp-mst)
[626.112708] Starting subtest: dp-mst
[626.116795] Subtest dp-mst: SKIP (0.000s)
[626.195445] [105/134] (400s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[626.468624] Starting subtest: cursor-rapid-movement-512x512
[626.472502] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[626.661553] [106/134] (399s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[626.750732] Starting subtest: addfb25-y-tiled-legacy
[626.753088] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[626.892627] [107/134] (399s left) kms_universal_plane (disable-primary-vs-flip)
[626.992835] Starting subtest: disable-primary-vs-flip
[626.994723] Starting dynamic subtest: pipe-A-eDP-1
[628.572237] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.577s)
[628.583138] Starting dynamic subtest: pipe-B-eDP-1
[630.802103] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.229s)
[630.812842] Starting dynamic subtest: pipe-C-eDP-1
[632.968658] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.166s)
[632.980071] Starting dynamic subtest: pipe-D-eDP-1
[635.157281] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.187s)
[635.159604] Subtest disable-primary-vs-flip: SUCCESS (8.165s)
[636.040220] [108/134] (390s left) gem_exec_reloc (basic-cpu-read)
[636.097383] Subtest basic-cpu-read: SKIP (0.000s)
[636.179851] [109/134] (390s left) gem_mmap_offset (ptrace)
[636.249884] Starting subtest: ptrace
[636.252274] Starting dynamic subtest: smem0-wb
[636.270971] Dynamic subtest smem0-wb: SUCCESS (0.020s)
[636.280774] Starting dynamic subtest: smem0-wc
[636.287489] Dynamic subtest smem0-wc: SUCCESS (0.016s)
[636.297909] Starting dynamic subtest: smem0-uc
[636.307600] Dynamic subtest smem0-uc: SUCCESS (0.019s)
[636.309846] Subtest ptrace: SUCCESS (0.060s)
[636.457490] [110/134] (390s left) gem_close_race (basic-threads)
[636.528383] Starting subtest: basic-threads
[637.904076] Subtest basic-threads: SUCCESS (1.378s)
[638.100507] [111/134] (388s left) syncobj_timeline (wait-all-for-submit-complex)
[638.177604] Starting subtest: wait-all-for-submit-complex
[638.389872] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[638.479709] [112/134] (388s left) kms_addfb_basic (bad-pitch-128)
[638.547027] Starting subtest: bad-pitch-128
[638.549707] Subtest bad-pitch-128: SUCCESS (0.000s)
[638.732653] [113/134] (387s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[638.825450] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[638.827363] Starting dynamic subtest: pipe-A-eDP-1
[639.571717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[639.582780] Starting dynamic subtest: pipe-B-eDP-1
[641.367483] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.794s)
[641.377835] Starting dynamic subtest: pipe-C-eDP-1
[643.204521] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.835s)
[643.215288] Starting dynamic subtest: pipe-D-eDP-1
[645.055892] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.850s)
[645.057900] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.222s)
[646.271706] [114/134] (380s left) prime_busy (before)
[646.336301] Starting subtest: before
[646.342005] Starting dynamic subtest: rcs0
[646.384943] Dynamic subtest rcs0: SUCCESS (0.042s)
[646.396860] Starting dynamic subtest: bcs0
[646.445159] Dynamic subtest bcs0: SUCCESS (0.060s)
[646.455720] Starting dynamic subtest: vcs0
[646.485087] Dynamic subtest vcs0: SUCCESS (0.039s)
[646.494882] Starting dynamic subtest: vcs1
[646.526427] Dynamic subtest vcs1: SUCCESS (0.041s)
[646.536183] Starting dynamic subtest: vecs0
[646.567029] Dynamic subtest vecs0: SUCCESS (0.040s)
[646.576818] Starting dynamic subtest: ccs0
[646.607909] Dynamic subtest ccs0: SUCCESS (0.040s)
[646.716664] Subtest before: SUCCESS (0.379s)
[646.808221] [115/134] (379s left) gen7_exec_parse (basic-allowed)
[646.879619] Subtest basic-allowed: SKIP (0.000s)
[646.949501] [116/134] (379s left) gem_exec_params (no-blt)
[647.017195] Starting subtest: no-blt
[647.019478] Subtest no-blt: SUCCESS (0.002s)
[647.147356] [117/134] (379s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[647.247616] Starting subtest: x-tiled-16bpp-rotate-90
[647.267893] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[647.397683] [118/134] (379s left) kms_async_flips (invalid-async-flip)
[647.490925] Starting subtest: invalid-async-flip
[647.873336] Starting dynamic subtest: pipe-A-eDP-1
[648.696303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[649.057216] Starting dynamic subtest: pipe-B-eDP-1
[649.831982] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[650.190013] Starting dynamic subtest: pipe-C-eDP-1
[650.955630] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[651.309806] Starting dynamic subtest: pipe-D-eDP-1
[652.077374] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[652.079691] Subtest invalid-async-flip: SUCCESS (4.589s)
[653.247719] [119/134] (373s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[653.365325] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[653.369704] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[653.490237] [120/134] (373s left) api_intel_allocator (gem-pool)
[653.547682] Starting subtest: gem-pool
[653.552788] Subtest gem-pool: SUCCESS (0.008s)
[653.686878] [121/134] (373s left) gem_exec_whisper (basic-fds-priority-all)
[653.750782] Starting subtest: basic-fds-priority-all
[677.021956] Subtest basic-fds-priority-all: SUCCESS (23.262s)
[677.217485] [122/134] (349s left) gem_fence_thrash (bo-write-verify-y)
[677.250846] Starting subtest: bo-write-verify-y
[677.275920] Subtest bo-write-verify-y: SKIP (0.021s)
[677.336692] [123/134] (349s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[677.380586] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[677.427126] [124/134] (349s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[677.478167] Starting subtest: yf-tiled-to-vebox-yf-tiled
[677.483134] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[677.675368] [125/134] (349s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[678.072537] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[678.928678] [126/134] (348s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[678.989363] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[679.057304] [127/134] (348s left) gem_busy (busy)
[679.122289] Starting subtest: busy
[679.124614] Starting dynamic subtest: all-engines
[679.211281] Dynamic subtest all-engines: SUCCESS (0.088s)
[679.221690] Starting dynamic subtest: rcs0
[680.973051] Dynamic subtest rcs0: SUCCESS (1.760s)
[680.984864] Starting dynamic subtest: bcs0
[681.033504] Dynamic subtest bcs0: SUCCESS (0.057s)
[681.044237] Starting dynamic subtest: vcs0
[681.073434] Dynamic subtest vcs0: SUCCESS (0.039s)
[681.083525] Starting dynamic subtest: vcs1
[682.953499] Dynamic subtest vcs1: SUCCESS (1.876s)
[682.965003] Starting dynamic subtest: vecs0
[684.937031] Dynamic subtest vecs0: SUCCESS (1.982s)
[684.948816] Starting dynamic subtest: ccs0
[686.986172] Dynamic subtest ccs0: SUCCESS (2.047s)
[686.988728] Subtest busy: SUCCESS (7.859s)
[687.388412] [128/134] (339s left) kms_color_pipeline (plane-lut1d-lut1d)
[687.497209] Starting subtest: plane-lut1d-lut1d
[687.511220] Starting dynamic subtest: pipe-A-eDP-1
[688.255885] Dynamic subtest pipe-A-eDP-1: FAIL (0.359s)
[688.942549] Starting dynamic subtest: pipe-B-eDP-1
[689.821827] Dynamic subtest pipe-B-eDP-1: FAIL (0.323s)
[690.376609] Starting dynamic subtest: pipe-C-eDP-1
[691.218973] Dynamic subtest pipe-C-eDP-1: FAIL (0.268s)
[691.715452] Starting dynamic subtest: pipe-D-eDP-1
[692.571377] Dynamic subtest pipe-D-eDP-1: FAIL (0.268s)
[692.573390] Subtest plane-lut1d-lut1d: FAIL (4.778s)
[693.104362] [129/134] (334s left) kms_plane_cursor (primary)
[693.205027] Starting subtest: primary
[693.209345] Starting dynamic subtest: pipe-A-eDP-1-size-64
[695.777734] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.573s)
[695.803851] Starting dynamic subtest: pipe-A-eDP-1-size-128
[698.425494] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.627s)
[698.449080] Starting dynamic subtest: pipe-A-eDP-1-size-256
[701.015572] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[701.329012] Starting dynamic subtest: pipe-B-eDP-1-size-64
[704.570824] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.250s)
[704.596764] Starting dynamic subtest: pipe-B-eDP-1-size-128
[707.173072] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[707.198397] Starting dynamic subtest: pipe-B-eDP-1-size-256
[709.773529] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[710.093966] Starting dynamic subtest: pipe-C-eDP-1-size-64
[713.110670] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.027s)
[713.139230] Starting dynamic subtest: pipe-C-eDP-1-size-128
[715.312862] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[715.340515] Starting dynamic subtest: pipe-C-eDP-1-size-256
[717.512506] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[717.831517] Starting dynamic subtest: pipe-D-eDP-1-size-64
[720.805666] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.985s)
[720.833226] Starting dynamic subtest: pipe-D-eDP-1-size-128
[723.039585] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[723.068221] Starting dynamic subtest: pipe-D-eDP-1-size-256
[725.251631] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.192s)
[725.561305] Subtest primary: SUCCESS (32.346s)
[726.431853] [130/134] (300s left) gem_tiled_swapping (non-threaded)
[726.509015] Subtest non-threaded: SKIP (0.000s)
[726.576775] [131/134] (300s left) syncobj_wait (invalid-signal-zero-handles)
[726.635460] Starting subtest: invalid-signal-zero-handles
[726.637719] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[726.753429] [132/134] (300s left) kms_joiner (basic-force-ultra-joiner)
[726.854567] Starting subtest: basic-force-ultra-joiner
[726.858602] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[726.934236] [133/134] (300s left) kms_psr (fbc-psr2-sprite-blt)
[727.026049] Starting subtest: fbc-psr2-sprite-blt
[727.028240] Starting dynamic subtest: eDP-1
[727.032309] Dynamic subtest eDP-1: SKIP (0.000s)
[727.036294] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[727.112210] [134/134] (300s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[727.203827] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[727.207916] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[727.345721] Closing watchdogs
results: parsing output: 0/ for test: gem_flink_basic
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_pxp
results: parsing output: 3/ for test: gem_create
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: sw_sync
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_pipe_crc_basic
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_multipipe_modeset
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_chamelium_edid
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gen9_exec_parse
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: gen9_exec_parse
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_hangman
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: i915_suspend
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: prime_self_import
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_plane_multiple
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: dmabuf_sync_file
results: parsing output: 52/ for test: gem_madvise
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_fbcon_fbt
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: kms_dirtyfb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_mmap_wc
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: gem_exec_nop
results: parsing output: 64/ for test: gem_workarounds
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_softpin
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_fenced_exec_thrash
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_partial_pwrite_pread
results: parsing output: 74/ for test: kms_properties
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: i915_pm_rps
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_balancer
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: gem_exec_await
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_scaling_modes
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: gem_ctx_sseu
results: parsing output: 96/ for test: kms_prop_blob
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_capture
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: kms_flip_scaled_crc
results: parsing output: 103/ for test: kms_feature_discovery
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: kms_universal_plane
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_mmap_offset
results: parsing output: 109/ for test: gem_close_race
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: prime_busy
results: parsing output: 114/ for test: gen7_exec_parse
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_async_flips
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: api_intel_allocator
results: parsing output: 120/ for test: gem_exec_whisper
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: gem_lmem_swapping
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: kms_chamelium_hpd
results: parsing output: 125/ for test: kms_pipe_b_c_ivb
results: parsing output: 126/ for test: gem_busy
results: parsing output: 127/ for test: kms_color_pipeline
results: parsing output: 128/ for test: kms_plane_cursor
results: parsing output: 129/ for test: gem_tiled_swapping
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_joiner
results: parsing output: 132/ for test: kms_psr
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.