[58.865665] Initializing watchdogs
[58.865710]   /dev/watchdog0
[58.880066] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.884082] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.886057] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.889344] [001/133] (960s left) perf (polling)
[59.047784] Starting subtest: polling
[59.049810] Starting dynamic subtest: 0-rcs0
[69.076965] Dynamic subtest 0-rcs0: SUCCESS (10.028s)
[69.084867] Starting dynamic subtest: 1-vecs0
[79.097057] Dynamic subtest 1-vecs0: SUCCESS (10.020s)
[79.100152] Subtest polling: SUCCESS (20.049s)
[79.142939] [002/133] (940s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[79.224574] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[79.228794] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[79.325174] [003/133] (940s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[79.401760] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[79.404896] Starting dynamic subtest: pipe-A-eDP-1
[79.428905] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[79.439305] Starting dynamic subtest: pipe-B-eDP-1
[79.460542] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[79.467248] Starting dynamic subtest: pipe-C-eDP-1
[79.488664] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[79.495157] Starting dynamic subtest: pipe-D-eDP-1
[79.516684] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.521062] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[81.648250] [004/133] (937s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[81.726537] Starting subtest: nonblocking-crc-frame-sequence
[81.728802] Starting dynamic subtest: pipe-A-eDP-1
[82.489207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.763s)
[82.498094] Starting dynamic subtest: pipe-B-eDP-1
[83.868814] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s)
[83.877139] Starting dynamic subtest: pipe-C-eDP-1
[85.265340] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[85.279746] Starting dynamic subtest: pipe-D-eDP-1
[86.586695] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[86.588725] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.860s)
[87.385699] [005/133] (932s left) gem_render_copy (x-tiled)
[87.456028] Starting subtest: x-tiled
[87.458411] Starting dynamic subtest: smem
[87.498313] Dynamic subtest smem: SUCCESS (0.042s)
[87.501202] Subtest x-tiled: SUCCESS (0.042s)
[87.721725] [006/133] (931s left) i915_hangman (hangcheck-unterminated)
[87.787477] Starting subtest: hangcheck-unterminated
[97.784090] Subtest hangcheck-unterminated: SUCCESS (9.995s)
[97.904499] [007/133] (921s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[98.275124] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[99.088985] [008/133] (920s left) gem_exec_fence (basic-wait-all)
[99.156966] Starting subtest: basic-wait-all
[99.244749] Subtest basic-wait-all: SUCCESS (0.089s)
[100.971974] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[100.974964] [009/133] (918s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[101.058810] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[107.863637] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.808s)
[107.990524] [010/133] (911s left) kms_cursor_edge_walk (128x128-top-edge)
[108.084201] Starting subtest: 128x128-top-edge
[108.086636] Starting dynamic subtest: pipe-A-eDP-1
[111.504854] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.421s)
[111.517412] Starting dynamic subtest: pipe-D-eDP-1
[114.628788] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[114.631198] Subtest 128x128-top-edge: SUCCESS (6.547s)
[115.423330] [011/133] (904s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[115.519613] Starting subtest: 2x-flip-vs-rmfb-interruptible
[115.530048] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.008s)
[115.636737] [012/133] (904s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[115.717888] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[122.427109] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.713s)
[122.564450] [013/133] (897s left) gem_ctx_engines (none)
[122.633626] Starting subtest: none
[122.636056] Subtest none: SUCCESS (0.002s)
[122.816445] [014/133] (897s left) gem_exec_reloc (basic-write-wc-active)
[122.882254] Subtest basic-write-wc-active: SKIP (0.000s)
[122.955688] [015/133] (896s left) gem_exec_fence (syncobj-timeline-export)
[123.474230] Starting subtest: syncobj-timeline-export
[123.481428] Subtest syncobj-timeline-export: SUCCESS (0.009s)
[124.901879] [016/133] (895s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[125.010032] Starting subtest: flip-vs-cursor-busy-crc-atomic
[125.812084] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.803s)
[126.653671] [017/133] (893s left) kms_color (ctm-0-25)
[126.722733] Starting subtest: ctm-0-25
[126.724640] Starting dynamic subtest: pipe-A-eDP-1
[130.263747] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.541s)
[130.274084] Starting dynamic subtest: pipe-B-eDP-1
[134.457324] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.193s)
[134.467508] Starting dynamic subtest: pipe-C-eDP-1
[138.509295] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.052s)
[138.517906] Starting dynamic subtest: pipe-D-eDP-1
[142.498229] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.989s)
[142.500520] Subtest ctm-0-25: SUCCESS (15.777s)
[143.318982] [018/133] (876s left) gem_basic (multigpu-create-close)
[143.386439] Starting subtest: multigpu-create-close
[143.390936] Subtest multigpu-create-close: SKIP (0.000s)
[143.487473] [019/133] (876s left) i915_pm_rc6_residency (media-rc6-accuracy)
[143.558323] Starting subtest: media-rc6-accuracy
[143.562883] Subtest media-rc6-accuracy: SKIP (0.000s)
[143.670538] [020/133] (876s left) sriov_basic (bind-unbind-vf)
[143.729910] Starting subtest: bind-unbind-vf
[143.732248] Starting dynamic subtest: vf-1
[143.806611] Dynamic subtest vf-1: FAIL (0.014s)
[143.816257] Starting dynamic subtest: vf-2
[143.888512] Dynamic subtest vf-2: FAIL (0.004s)
[143.898513] Starting dynamic subtest: vf-3
[143.971946] Dynamic subtest vf-3: FAIL (0.004s)
[143.981105] Starting dynamic subtest: vf-4
[144.053284] Dynamic subtest vf-4: FAIL (0.004s)
[144.063190] Starting dynamic subtest: vf-5
[144.135951] Dynamic subtest vf-5: FAIL (0.004s)
[144.144649] Starting dynamic subtest: vf-6
[144.217591] Dynamic subtest vf-6: FAIL (0.004s)
[144.227727] Starting dynamic subtest: vf-7
[144.295023] Dynamic subtest vf-7: FAIL (0.004s)
[144.303775] Starting dynamic subtest: vf-random
[144.362796] Dynamic subtest vf-random: FAIL (0.004s)
[144.371364] Starting dynamic subtest: vf-last
[144.432575] Dynamic subtest vf-last: FAIL (0.504s)
[144.434566] Subtest bind-unbind-vf: FAIL (0.551s)
[144.469663] [021/133] (875s left) gem_readwrite (read-write)
[144.529419] Subtest read-write: SKIP (0.000s)
[144.590176] [022/133] (875s left) gem_basic (create-fd-close)
[144.654081] Starting subtest: create-fd-close
[144.658514] Subtest create-fd-close: SUCCESS (0.000s)
[144.759403] [023/133] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[144.849811] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[151.697369] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.848s)
[151.832254] [024/133] (868s left) kms_addfb_basic (legacy-format)
[151.896421] Starting subtest: legacy-format
[151.919652] Subtest legacy-format: SUCCESS (0.021s)
[152.043607] [025/133] (868s left) gem_exec_schedule (preempt-queue-contexts-chain)
[152.115805] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[152.403715] [026/133] (867s left) kms_chamelium_frames (dp-crc-multiple)
[152.765299] Subtest dp-crc-multiple: SKIP (0.000s)
[153.559681] [027/133] (866s left) gem_mmap_offset (close-race)
[153.616823] Starting subtest: close-race
[173.740523] Subtest close-race: SUCCESS (20.122s)
[173.869475] [028/133] (846s left) api_intel_bb (object-reloc-keep-cache)
[173.931072] Starting subtest: object-reloc-keep-cache
[173.936903] Subtest object-reloc-keep-cache: SKIP (0.006s)
[174.088868] [029/133] (846s left) gem_pxp (create-valid-protected-context)
[174.210713] Starting subtest: create-valid-protected-context
[174.213211] Subtest create-valid-protected-context: SUCCESS (0.002s)
[174.329530] [030/133] (846s left) kms_selftest (drm_dp_mst_helper)
[174.362179] Starting subtest: drm_dp_mst_helper
[174.403251] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[174.494395] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.090s)
[174.502416] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[174.585541] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.093s)
[174.593907] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[174.697426] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.111s)
[174.699731] Subtest drm_dp_mst_helper: SUCCESS (0.337s)
[174.859215] [031/133] (845s left) i915_drm_fdinfo (most-busy-check-all)
[174.900323] Starting subtest: most-busy-check-all
[174.902239] Starting dynamic subtest: rcs0
[174.908560] Dynamic subtest rcs0: SKIP (0.007s)
[174.920996] Starting dynamic subtest: bcs0
[174.924716] Dynamic subtest bcs0: SKIP (0.000s)
[174.931939] Starting dynamic subtest: vcs0
[174.935472] Dynamic subtest vcs0: SKIP (0.000s)
[174.942663] Starting dynamic subtest: vcs1
[174.946301] Dynamic subtest vcs1: SKIP (0.000s)
[174.953239] Starting dynamic subtest: vecs0
[174.956806] Dynamic subtest vecs0: SKIP (0.000s)
[174.963852] Starting dynamic subtest: ccs0
[174.967679] Dynamic subtest ccs0: SKIP (0.000s)
[174.971062] Subtest most-busy-check-all: SKIP (0.012s)
[175.004849] [032/133] (845s left) kms_vblank (ts-continuation-idle)
[175.100387] Starting subtest: ts-continuation-idle
[175.102260] Starting dynamic subtest: pipe-A-eDP-1
[175.501408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s)
[175.514903] Starting dynamic subtest: pipe-D-eDP-1
[176.567112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.064s)
[176.569313] Subtest ts-continuation-idle: SUCCESS (1.470s)
[177.425464] [033/133] (843s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[177.481458] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[177.483419] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[177.576280] [034/133] (843s left) gem_ctx_sseu (engines)
[177.631109] Subtest engines: SKIP (0.000s)
[177.685277] [035/133] (843s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[177.779643] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[177.786671] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.008s)
[177.892503] [036/133] (842s left) gem_exec_balancer (parallel-keep-in-fence)
[178.156259] Starting subtest: parallel-keep-in-fence
[179.251298] Subtest parallel-keep-in-fence: SUCCESS (1.095s)
[179.369610] [037/133] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[179.455149] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[179.459163] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[179.556012] [038/133] (841s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[179.613958] Subtest writes-after-reads: SKIP (0.000s)
[179.671035] [039/133] (841s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[179.728515] Starting subtest: wait-all-for-submit-delayed-submit
[179.832057] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[179.906779] [040/133] (841s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[179.980994] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[179.983380] Starting dynamic subtest: pipe-A-eDP-1
[180.004641] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[180.014392] Starting dynamic subtest: pipe-B-eDP-1
[180.035211] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[180.043061] Starting dynamic subtest: pipe-C-eDP-1
[180.063130] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[180.070829] Starting dynamic subtest: pipe-D-eDP-1
[180.090609] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[180.092818] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[182.306471] [041/133] (838s left) kms_dsc (dsc-fractional-bpp)
[182.375926] Starting subtest: dsc-fractional-bpp
[182.389561] Subtest dsc-fractional-bpp: SKIP (0.000s)
[182.454177] [042/133] (838s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[182.528120] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[182.532086] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[182.595708] [043/133] (838s left) kms_async_flips (invalid-async-flip)
[182.677023] Starting subtest: invalid-async-flip
[183.052592] Starting dynamic subtest: pipe-A-eDP-1
[183.848243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s)
[184.204878] Starting dynamic subtest: pipe-B-eDP-1
[185.062897] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.865s)
[185.432564] Starting dynamic subtest: pipe-C-eDP-1
[186.184208] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.759s)
[186.553378] Starting dynamic subtest: pipe-D-eDP-1
[187.324634] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[187.327057] Subtest invalid-async-flip: SUCCESS (4.650s)
[188.470513] [044/133] (832s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[188.542338] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[195.764164] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.224s)
[195.889318] [045/133] (825s left) syncobj_timeline (invalid-transfer-bad-pad)
[195.945394] Starting subtest: invalid-transfer-bad-pad
[195.947340] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[196.060785] [046/133] (825s left) kms_addfb_basic (addfb25-bad-modifier)
[196.128991] Starting subtest: addfb25-bad-modifier
[196.131290] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[196.224392] [047/133] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[196.303307] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[196.307786] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[196.427148] [048/133] (824s left) kms_lease (lessee-list)
[196.501586] Starting subtest: lessee-list
[196.503994] Starting dynamic subtest: pipe-A-eDP-1
[196.506510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[196.515451] Starting dynamic subtest: pipe-B-eDP-1
[196.517382] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[196.525057] Starting dynamic subtest: pipe-C-eDP-1
[196.526985] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[196.534635] Starting dynamic subtest: pipe-D-eDP-1
[196.536571] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[196.538481] Subtest lessee-list: SUCCESS (0.010s)
[196.615412] [049/133] (824s left) kms_rotation_crc (sprite-rotation-270)
[196.683088] Starting subtest: sprite-rotation-270
[196.687669] Subtest sprite-rotation-270: SKIP (0.001s)
[196.781988] [050/133] (824s left) gen7_exec_parse (basic-offset)
[196.834646] Subtest basic-offset: SKIP (0.000s)
[196.904308] [051/133] (824s left) syncobj_eventfd (timeline-wait-before-signal)
[196.959682] Starting subtest: timeline-wait-before-signal
[196.990773] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[197.068654] [052/133] (824s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[197.147347] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[197.151259] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[197.233046] [053/133] (824s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[197.304180] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[197.307563] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[197.374757] [054/133] (824s left) gem_partial_pwrite_pread (reads-uncached)
[197.423518] Subtest reads-uncached: SKIP (0.000s)
[197.481278] [055/133] (824s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[197.620209] Starting subtest: cursor-rapid-movement-32x10
[197.665782] Subtest cursor-rapid-movement-32x10: SKIP (0.041s)
[197.923961] [056/133] (823s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[197.998215] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[198.025610] Starting dynamic subtest: pipe-A-plane-0
[198.313928] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[198.322485] Starting dynamic subtest: pipe-A-plane-3
[198.547368] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[198.555870] Starting dynamic subtest: pipe-A-plane-5
[198.559577] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[199.698589] Starting dynamic subtest: pipe-B-plane-0
[200.002918] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[200.013671] Starting dynamic subtest: pipe-B-plane-3
[200.236133] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[200.244582] Starting dynamic subtest: pipe-B-plane-5
[200.249174] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[200.550515] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.550s)
[201.371566] [057/133] (820s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[201.463881] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[201.468196] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[201.556586] [058/133] (820s left) kms_prime (basic-modeset-hybrid)
[201.629885] Subtest basic-modeset-hybrid: SKIP (0.000s)
[201.724562] [059/133] (819s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[201.802344] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[201.804599] Starting dynamic subtest: pipe-A-eDP-1
[207.650945] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.852s)
[207.661086] Starting dynamic subtest: pipe-B-eDP-1
[214.319769] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.666s)
[214.322107] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.521s)
[215.179784] [060/133] (806s left) gem_exec_whisper (basic-fds-priority)
[215.242393] Starting subtest: basic-fds-priority
[239.842543] Subtest basic-fds-priority: SUCCESS (24.594s)
[240.036379] [061/133] (781s left) kms_pm_backlight (fade-with-suspend)
[240.115397] Starting subtest: fade-with-suspend
[256.526720] Starting dynamic subtest: eDP-1
[259.010517] Dynamic subtest eDP-1: SUCCESS (2.485s)
[259.012849] Subtest fade-with-suspend: SUCCESS (3.833s)
[259.843075] [062/133] (761s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[259.964572] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[259.968912] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[260.108353] [063/133] (761s left) gem_madvise (dontneed-before-pwrite)
[260.151700] Starting subtest: dontneed-before-pwrite
[260.164886] Subtest dontneed-before-pwrite: SKIP (0.015s)
[260.225568] [064/133] (761s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[260.303596] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[260.305882] Starting dynamic subtest: pipe-A-default-mode
[263.093185] Dynamic subtest pipe-A-default-mode: SUCCESS (2.787s)
[263.095305] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.788s)
[263.922169] [065/133] (758s left) sysfs_preempt_timeout (invalid)
[263.989395] Starting subtest: invalid
[263.991817] Starting dynamic subtest: vecs0
[263.994190] Dynamic subtest vecs0: SUCCESS (0.000s)
[264.004909] Starting dynamic subtest: ccs0
[264.007172] Dynamic subtest ccs0: SUCCESS (0.000s)
[264.016241] Starting dynamic subtest: vcs0
[264.018406] Dynamic subtest vcs0: SUCCESS (0.000s)
[264.027449] Starting dynamic subtest: bcs0
[264.029315] Dynamic subtest bcs0: SUCCESS (0.000s)
[264.038310] Starting dynamic subtest: rcs0
[264.040460] Dynamic subtest rcs0: SUCCESS (0.000s)
[264.049207] Starting dynamic subtest: vcs1
[264.051386] Dynamic subtest vcs1: SUCCESS (0.000s)
[264.053614] Subtest invalid: SUCCESS (0.005s)
[264.090736] [066/133] (757s left) gem_mmap_gtt (basic-short)
[264.143664] Subtest basic-short: SKIP (0.000s)
[264.204686] [067/133] (757s left) prime_self_import (reimport-vs-gem_close-race)
[264.250221] Starting subtest: reimport-vs-gem_close-race
[269.324046] Subtest reimport-vs-gem_close-race: SUCCESS (5.073s)
[269.403482] [068/133] (752s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[269.475200] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[269.477009] Starting dynamic subtest: pipe-A-eDP-1
[270.399565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.917s)
[270.409607] Starting dynamic subtest: pipe-B-eDP-1
[272.411440] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.009s)
[272.421529] Starting dynamic subtest: pipe-C-eDP-1
[274.423471] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.011s)
[274.433063] Starting dynamic subtest: pipe-D-eDP-1
[276.444380] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.019s)
[276.446705] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.961s)
[277.645789] [069/133] (744s left) kms_flip (dpms-vs-vblank-race)
[277.722458] Starting subtest: dpms-vs-vblank-race
[277.724722] Starting dynamic subtest: A-eDP1
[281.605884] Dynamic subtest A-eDP1: SUCCESS (3.884s)
[281.616084] Starting dynamic subtest: B-eDP1
[286.233483] Dynamic subtest B-eDP1: SUCCESS (4.623s)
[286.243575] Starting dynamic subtest: C-eDP1
[290.850176] Dynamic subtest C-eDP1: SUCCESS (4.616s)
[290.860248] Starting dynamic subtest: D-eDP1
[295.481108] Dynamic subtest D-eDP1: SUCCESS (4.627s)
[295.483120] Subtest dpms-vs-vblank-race: SUCCESS (17.759s)
[296.359307] [070/133] (725s left) gem_exec_balancer (bonded-true-hang)
[296.624953] Starting subtest: bonded-true-hang
[296.629795] Subtest bonded-true-hang: SKIP (0.000s)
[296.722845] [071/133] (725s left) gem_wait (busy)
[296.791753] Starting subtest: busy
[296.794379] Starting dynamic subtest: all-engines
[297.902998] Dynamic subtest all-engines: SUCCESS (1.109s)
[297.914624] Starting dynamic subtest: rcs0
[298.444811] Dynamic subtest rcs0: SUCCESS (0.540s)
[298.457963] Starting dynamic subtest: bcs0
[298.985148] Dynamic subtest bcs0: SUCCESS (0.539s)
[298.997655] Starting dynamic subtest: vcs0
[300.911006] Dynamic subtest vcs0: SUCCESS (1.924s)
[300.923760] Starting dynamic subtest: vcs1
[302.895036] Dynamic subtest vcs1: SUCCESS (1.980s)
[302.908166] Starting dynamic subtest: vecs0
[304.942738] Dynamic subtest vecs0: SUCCESS (2.045s)
[304.954937] Starting dynamic subtest: ccs0
[305.485030] Dynamic subtest ccs0: SUCCESS (0.541s)
[305.487787] Subtest busy: SUCCESS (8.692s)
[305.683087] [072/133] (716s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[305.762374] Starting subtest: y-tiled-32bpp-rotate-0
[305.766799] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[305.851553] [073/133] (716s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[305.945806] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[309.679570] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.739s)
[310.853622] [074/133] (711s left) kms_flip (dpms-off-confusion)
[310.951572] Starting subtest: dpms-off-confusion
[310.953927] Starting dynamic subtest: A-eDP1
[319.643773] Dynamic subtest A-eDP1: SUCCESS (8.690s)
[319.657164] Starting dynamic subtest: B-eDP1
[328.272947] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[328.282998] Starting dynamic subtest: C-eDP1
[336.904358] Dynamic subtest C-eDP1: SUCCESS (8.629s)
[336.915256] Starting dynamic subtest: D-eDP1
[345.541391] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[345.543603] Subtest dpms-off-confusion: SUCCESS (34.589s)
[346.718463] [075/133] (675s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[346.795296] Starting subtest: plane-all-transition-nonblocking-fencing
[346.797539] Starting dynamic subtest: pipe-A-eDP-1
[349.289957] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[349.596611] Starting dynamic subtest: pipe-B-eDP-1
[352.844426] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.257s)
[353.150429] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.356s)
[353.970680] [076/133] (668s left) kms_psr (psr-primary-blt)
[354.062177] Starting subtest: psr-primary-blt
[354.064300] Starting dynamic subtest: eDP-1
[355.757766] Dynamic subtest eDP-1: SUCCESS (1.695s)
[355.759683] Subtest psr-primary-blt: SUCCESS (1.696s)
[356.636030] [077/133] (665s left) kms_psr (fbc-psr-no-drrs)
[356.712911] Starting subtest: fbc-psr-no-drrs
[356.715060] Starting dynamic subtest: eDP-1
[356.719032] Dynamic subtest eDP-1: SKIP (0.000s)
[356.722984] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[356.786410] [078/133] (665s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[356.869202] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[356.873562] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[356.938804] [079/133] (665s left) api_intel_allocator (simple-allocator)
[356.999232] Starting subtest: simple-allocator
[357.001457] Starting dynamic subtest: basic
[357.003346] Dynamic subtest basic: SUCCESS (0.003s)
[357.014194] Starting dynamic subtest: parallel-one
[357.186201] Dynamic subtest parallel-one: SUCCESS (0.184s)
[357.195658] Starting dynamic subtest: print
[357.198055] Dynamic subtest print: SUCCESS (0.000s)
[357.207204] Starting dynamic subtest: reuse
[357.209360] Dynamic subtest reuse: SUCCESS (0.000s)
[357.218073] Starting dynamic subtest: reserve
[357.220286] Dynamic subtest reserve: SUCCESS (0.000s)
[357.229115] Starting dynamic subtest: fork-reopen-allocator
[357.231313] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[357.233450] Subtest simple-allocator: SUCCESS (0.207s)
[357.330427] [080/133] (665s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[357.385509] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[357.490913] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[357.578894] [081/133] (665s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[357.684737] Starting subtest: short-flip-after-cursor-atomic-transitions
[358.624848] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.938s)
[359.455184] [082/133] (663s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[359.543594] Starting subtest: 4-tiled-32bpp-rotate-0
[360.989650] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.448s)
[361.143522] [083/133] (661s left) syncobj_basic (bad-handle-to-fd)
[361.200659] Starting subtest: bad-handle-to-fd
[361.202592] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[361.294704] [084/133] (661s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[361.375884] Starting subtest: x-tiled-16bpp-rotate-270
[361.398358] Subtest x-tiled-16bpp-rotate-270: SKIP (0.022s)
[361.514573] [085/133] (661s left) kms_psr (psr2-sprite-mmap-gtt)
[361.585260] Starting subtest: psr2-sprite-mmap-gtt
[361.587040] Starting dynamic subtest: eDP-1
[362.970043] Dynamic subtest eDP-1: SKIP (1.380s)
[362.974857] Subtest psr2-sprite-mmap-gtt: SKIP (1.382s)
[363.115488] [086/133] (659s left) kms_vrr (seamless-rr-switch-virtual)
[363.198879] Starting subtest: seamless-rr-switch-virtual
[363.205232] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[363.282515] [087/133] (659s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[363.337912] Starting subtest: invalid-bsd2-flag-on-blt
[363.340070] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[363.456768] [088/133] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[363.537273] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[363.541548] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[363.621408] [089/133] (659s left) dumb_buffer (map-invalid-size)
[363.667305] Starting subtest: map-invalid-size
[363.669180] Subtest map-invalid-size: SUCCESS (0.000s)
[363.754421] [090/133] (659s left) kms_psr (fbc-pr-primary-mmap-gtt)
[363.821895] Starting subtest: fbc-pr-primary-mmap-gtt
[363.826165] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[363.923272] [091/133] (659s left) gem_spin_batch (spin-all-new)
[363.979911] Starting subtest: spin-all-new
[363.998672] Subtest spin-all-new: SUCCESS (0.019s)
[365.977050] [092/133] (657s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[366.037383] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[366.118329] [093/133] (656s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[366.201532] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[366.203657] Starting dynamic subtest: pipe-A-eDP-1
[366.225308] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[366.237148] Starting dynamic subtest: pipe-B-eDP-1
[366.257541] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[366.266777] Starting dynamic subtest: pipe-C-eDP-1
[366.287195] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[366.296045] Starting dynamic subtest: pipe-D-eDP-1
[366.316852] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[366.320709] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[368.468267] [094/133] (654s left) gem_ctx_shared (create-shared-gtt)
[368.521575] Starting subtest: create-shared-gtt
[370.674885] Subtest create-shared-gtt: SUCCESS (2.152s)
[371.027265] [095/133] (652s left) kms_invalid_mode (bad-hsync-start)
[371.103570] Starting subtest: bad-hsync-start
[371.105714] Starting dynamic subtest: pipe-A-eDP-1
[371.389227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[371.399237] Starting dynamic subtest: pipe-B-eDP-1
[371.401124] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[371.409949] Starting dynamic subtest: pipe-C-eDP-1
[371.412239] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[371.421367] Starting dynamic subtest: pipe-D-eDP-1
[371.423577] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[371.425695] Subtest bad-hsync-start: SUCCESS (0.293s)
[372.176022] [096/133] (651s left) kms_psr (psr2-basic)
[372.251911] Starting subtest: psr2-basic
[372.254226] Starting dynamic subtest: eDP-1
[373.862183] Dynamic subtest eDP-1: SUCCESS (1.609s)
[373.864473] Subtest psr2-basic: SUCCESS (1.610s)
[374.660367] [097/133] (648s left) gem_workarounds (basic-read)
[374.721370] Starting subtest: basic-read
[374.735541] Subtest basic-read: SUCCESS (0.013s)
[374.862316] [098/133] (648s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[374.949309] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[374.951588] Starting dynamic subtest: pipe-A
[374.970204] Dynamic subtest pipe-A: SKIP (0.015s)
[374.986525] Starting dynamic subtest: pipe-B
[374.999039] Dynamic subtest pipe-B: SKIP (0.029s)
[375.008936] Starting dynamic subtest: pipe-C
[375.029423] Dynamic subtest pipe-C: SKIP (0.029s)
[375.039004] Starting dynamic subtest: pipe-D
[375.056232] Dynamic subtest pipe-D: SKIP (0.028s)
[375.059916] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.104s)
[375.170179] [099/133] (648s left) gem_softpin (noreloc)
[375.229058] Starting subtest: noreloc
[380.651127] Subtest noreloc: SUCCESS (5.421s)
[380.784631] [100/133] (642s left) gem_exercise_blt (fast-copy-emit)
[380.841045] Starting subtest: fast-copy-emit
[380.843491] Starting dynamic subtest: linear-smem-smem-emit
[380.868183] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.027s)
[380.880831] Starting dynamic subtest: xmajor-smem-smem-emit
[380.887245] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.018s)
[380.896414] Starting dynamic subtest: tile4-smem-smem-emit
[380.906575] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.019s)
[380.915789] Starting dynamic subtest: tile64-smem-smem-emit
[380.924545] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[380.926807] Subtest fast-copy-emit: SUCCESS (0.084s)
[381.074558] [101/133] (642s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[381.152591] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[384.743910] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.597s)
[385.965574] [102/133] (637s left) gem_exec_schedule (preempt-queue-chain)
[386.051347] Subtest preempt-queue-chain: SKIP (0.000s)
[386.336033] [103/133] (637s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[386.420872] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[395.814176] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.394s)
[395.939387] [104/133] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[396.032355] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[396.036241] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[396.130442] [105/133] (627s left) gem_mmap_gtt (cpuset-big-copy-odd)
[396.196869] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[396.266512] [106/133] (627s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[396.378597] Starting subtest: dp-mst-lic-type-0-hdcp14
[396.383099] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[396.525536] [107/133] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[396.600418] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[396.604294] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[396.713550] [108/133] (627s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[396.801179] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[396.805219] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[396.901686] [109/133] (626s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[396.978916] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[401.372907] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.398s)
[402.508319] [110/133] (621s left) prime_mmap_coherency (read)
[402.556535] Starting subtest: read
[407.931763] Subtest read: SUCCESS (5.373s)
[408.051621] [111/133] (615s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[408.106770] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[408.111102] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[408.292644] [112/133] (615s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[408.365818] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[415.719602] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.356s)
[415.854910] [113/133] (608s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[415.942734] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[415.947212] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[416.043722] [114/133] (607s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[416.133176] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[416.135500] Starting dynamic subtest: pipe-A-eDP-1
[416.195774] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[416.207895] Starting dynamic subtest: pipe-B-eDP-1
[416.265935] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[416.278327] Starting dynamic subtest: pipe-C-eDP-1
[416.335811] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[416.345960] Starting dynamic subtest: pipe-D-eDP-1
[416.402848] Dynamic subtest pipe-D-eDP-1: SKIP (0.004s)
[416.407327] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.027s)
[418.461184] [115/133] (605s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[418.575903] Starting subtest: verify-pxp-execution-after-suspend-resume
[425.630557] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.054s)
[425.774020] [116/133] (598s left) perf_pmu (event-wait)
[425.822768] Starting subtest: event-wait
[425.824660] Starting dynamic subtest: rcs0
[425.829314] Dynamic subtest rcs0: SKIP (0.000s)
[425.833743] Subtest event-wait: SKIP (0.001s)
[425.946334] [117/133] (598s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[426.025186] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[426.027780] Starting dynamic subtest: pipe-A-eDP-1
[426.050429] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[426.063108] Starting dynamic subtest: pipe-B-eDP-1
[426.084182] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[426.093996] Starting dynamic subtest: pipe-C-eDP-1
[426.115937] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[426.125089] Starting dynamic subtest: pipe-D-eDP-1
[426.147455] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[426.151515] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[428.256781] [118/133] (595s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[428.317305] Starting subtest: multi-wait-for-submit-unsubmitted
[428.418191] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[428.511425] [119/133] (595s left) kms_properties (crtc-properties-legacy)
[428.577566] Starting subtest: crtc-properties-legacy
[428.579824] Starting dynamic subtest: pipe-A-eDP-1
[429.011840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[429.022419] Starting dynamic subtest: pipe-B-eDP-1
[430.203998] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.190s)
[430.215006] Starting dynamic subtest: pipe-C-eDP-1
[431.340414] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.137s)
[431.351238] Starting dynamic subtest: pipe-D-eDP-1
[432.454040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.111s)
[432.456335] Subtest crtc-properties-legacy: SUCCESS (3.877s)
[433.271912] [120/133] (590s left) gem_userptr_blits (map-fixed-invalidate)
[433.344079] Starting subtest: map-fixed-invalidate
[433.348793] Subtest map-fixed-invalidate: SKIP (0.000s)
[433.486360] [121/133] (590s left) i915_suspend (basic-s2idle-without-i915)
[433.522586] Starting subtest: basic-s2idle-without-i915
[453.891212] Subtest basic-s2idle-without-i915: SUCCESS (5.551s)
[453.988207] [122/133] (570s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[454.064556] Starting subtest: multi-wait-for-submit-available-signaled
[454.066944] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[454.159671] [123/133] (570s left) kms_big_fb (linear-16bpp-rotate-180)
[454.250258] Starting subtest: linear-16bpp-rotate-180
[455.590093] Subtest linear-16bpp-rotate-180: SUCCESS (1.337s)
[455.709586] [124/133] (568s left) drm_read (fault-buffer)
[455.832685] Starting subtest: fault-buffer
[455.834633] Subtest fault-buffer: SUCCESS (0.000s)
[455.943820] [125/133] (568s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[456.007904] Starting subtest: primary-y-tiled-reflect-x-270
[456.011429] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[456.107471] [126/133] (568s left) kms_cursor_crc (cursor-offscreen-64x64)
[456.260936] Starting subtest: cursor-offscreen-64x64
[456.264887] Starting dynamic subtest: pipe-A-eDP-1
[458.223931] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.956s)
[458.259439] Starting dynamic subtest: pipe-D-eDP-1
[460.839081] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s)
[460.841396] Subtest cursor-offscreen-64x64: SUCCESS (4.571s)
[461.691499] [127/133] (562s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[461.764335] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[461.768428] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[461.864259] [128/133] (562s left) prime_self_import (basic-with_fd_dup)
[461.902076] Starting subtest: basic-with_fd_dup
[461.923273] Subtest basic-with_fd_dup: SUCCESS (0.022s)
[462.019143] [129/133] (562s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[462.097217] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[462.099338] Starting dynamic subtest: pipe-A
[462.119303] Dynamic subtest pipe-A: SKIP (0.018s)
[462.128136] Starting dynamic subtest: pipe-B
[462.155459] Dynamic subtest pipe-B: SKIP (0.034s)
[462.166355] Starting dynamic subtest: pipe-C
[462.189869] Dynamic subtest pipe-C: SKIP (0.034s)
[462.198570] Starting dynamic subtest: pipe-D
[462.220266] Dynamic subtest pipe-D: SKIP (0.030s)
[462.223843] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.119s)
[462.327636] [130/133] (562s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[462.399786] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[462.404230] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[462.474172] [131/133] (562s left) gem_ctx_isolation (preservation)
[462.534003] Starting subtest: preservation
[462.536332] Starting dynamic subtest: rcs0
[462.658087] Dynamic subtest rcs0: SUCCESS (0.124s)
[462.670136] Starting dynamic subtest: bcs0
[462.805792] Dynamic subtest bcs0: SUCCESS (0.147s)
[462.815549] Starting dynamic subtest: vcs0
[462.961746] Dynamic subtest vcs0: SUCCESS (0.155s)
[462.971057] Starting dynamic subtest: vcs1
[464.823434] Dynamic subtest vcs1: SUCCESS (1.859s)
[464.834782] Starting dynamic subtest: vecs0
[466.809570] Dynamic subtest vecs0: SUCCESS (1.983s)
[466.822655] Starting dynamic subtest: ccs0
[468.880282] Dynamic subtest ccs0: SUCCESS (2.068s)
[468.882746] Subtest preservation: SUCCESS (6.341s)
[469.100307] [132/133] (555s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[469.184364] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[469.786864] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[469.959324] [133/133] (554s left) gem_exec_schedule (fairslice)
[470.023119] Starting subtest: fairslice
[470.025016] Starting dynamic subtest: rcs0
[472.037118] Dynamic subtest rcs0: SUCCESS (2.018s)
[472.046767] Starting dynamic subtest: bcs0
[474.054256] Dynamic subtest bcs0: SUCCESS (2.016s)
[474.064110] Starting dynamic subtest: vcs0
[476.072464] Dynamic subtest vcs0: SUCCESS (2.017s)
[476.082034] Starting dynamic subtest: vcs1
[478.092391] Dynamic subtest vcs1: SUCCESS (2.017s)
[478.102168] Starting dynamic subtest: vecs0
[480.111295] Dynamic subtest vecs0: SUCCESS (2.016s)
[480.121085] Starting dynamic subtest: ccs0
[482.131917] Dynamic subtest ccs0: SUCCESS (2.020s)
[482.133783] Subtest fairslice: SUCCESS (12.110s)
[482.427355] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_pipe_crc_basic
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: i915_hangman
results: parsing output: 6/ for test: kms_chamelium_hpd
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_edge_walk
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_engines
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_basic
results: parsing output: 18/ for test: i915_pm_rc6_residency
results: parsing output: 19/ for test: sriov_basic
results: parsing output: 20/ for test: gem_readwrite
results: parsing output: 21/ for test: gem_basic
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_chamelium_frames
results: parsing output: 26/ for test: gem_mmap_offset
results: parsing output: 27/ for test: api_intel_bb
results: parsing output: 28/ for test: gem_pxp
results: parsing output: 29/ for test: kms_selftest
results: parsing output: 30/ for test: i915_drm_fdinfo
results: parsing output: 31/ for test: kms_vblank
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: gem_ctx_sseu
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: gem_exec_balancer
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_dsc
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_addfb_basic
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_lease
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: gen7_exec_parse
results: parsing output: 50/ for test: syncobj_eventfd
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: gem_partial_pwrite_pread
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_prime
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: gem_exec_whisper
results: parsing output: 60/ for test: kms_pm_backlight
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: gem_madvise
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: sysfs_preempt_timeout
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: prime_self_import
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: gem_wait
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_atomic_transition
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: api_intel_allocator
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: syncobj_basic
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_vrr
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: dumb_buffer
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: kms_invalid_mode
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_workarounds
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: gem_softpin
results: parsing output: 99/ for test: gem_exercise_blt
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_content_protection
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: prime_mmap_coherency
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: gem_pxp
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_properties
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: i915_suspend
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: drm_read
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: prime_self_import
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: gem_ctx_isolation
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: gem_exec_schedule
Done.