[59.581355] Initializing watchdogs
[59.581400]   /dev/watchdog0
[59.595541] [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]
[59.599762] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.602369] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.605884] [001/130] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[59.722112] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[59.726296] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.823605] [002/130] (960s left) prime_vgem (coherency-gtt)
[59.914404] Starting subtest: coherency-gtt
[59.919124] Subtest coherency-gtt: SKIP (0.000s)
[60.023304] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[60.026204] [003/130] (960s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[60.104815] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[60.107162] Starting dynamic subtest: pipe-A-eDP-1
[60.130363] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[60.140219] Starting dynamic subtest: pipe-B-eDP-1
[60.161415] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[60.167803] Starting dynamic subtest: pipe-C-eDP-1
[60.189049] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[60.196254] Starting dynamic subtest: pipe-D-eDP-1
[60.216558] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[60.220655] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.003s)
[62.368691] [004/130] (957s left) gem_softpin (allocator-basic)
[62.434918] Starting subtest: allocator-basic
[62.508824] Subtest allocator-basic: SUCCESS (0.076s)
[62.637370] [005/130] (957s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[62.729266] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[62.733217] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[62.831877] [006/130] (957s left) gem_exec_nop (basic-sequential)
[62.900533] Starting subtest: basic-sequential
[77.776480] Subtest basic-sequential: SUCCESS (14.924s)
[77.970018] [007/130] (942s left) syncobj_wait (invalid-single-wait-unsubmitted)
[78.023794] Starting subtest: invalid-single-wait-unsubmitted
[78.026107] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[78.115402] [008/130] (942s left) kms_plane_scaling (2x-scaler-multi-pipe)
[78.206911] Starting subtest: 2x-scaler-multi-pipe
[78.211609] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[78.301919] [009/130] (942s left) kms_plane (plane-panning-bottom-right-suspend)
[78.386646] Starting subtest: plane-panning-bottom-right-suspend
[78.389068] Starting dynamic subtest: pipe-A
[96.253232] Dynamic subtest pipe-A: SUCCESS (3.653s)
[96.271532] Starting dynamic subtest: pipe-B
[115.211364] Dynamic subtest pipe-B: SUCCESS (3.471s)
[115.213393] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.126s)
[116.000778] [010/130] (904s left) vgem_slow (nohang)
[116.052693] Starting subtest: nohang
[126.535931] Subtest nohang: SUCCESS (10.644s)
[126.614561] [011/130] (893s left) gem_exec_schedule (in-order)
[126.698338] Starting subtest: in-order
[126.700527] Starting dynamic subtest: rcs0
[126.865115] Dynamic subtest rcs0: SUCCESS (0.173s)
[126.876327] Starting dynamic subtest: vcs0
[126.974173] Dynamic subtest vcs0: SUCCESS (0.109s)
[126.986146] Starting dynamic subtest: vcs1
[127.084081] Dynamic subtest vcs1: SUCCESS (0.110s)
[127.096336] Starting dynamic subtest: vecs0
[127.192661] Dynamic subtest vecs0: SUCCESS (0.110s)
[127.207020] Starting dynamic subtest: ccs0
[127.323053] Dynamic subtest ccs0: SUCCESS (0.131s)
[127.325459] Subtest in-order: SUCCESS (0.635s)
[128.196752] [012/130] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[128.299882] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[128.304051] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[128.398201] [013/130] (892s left) gem_eio (in-flight-external)
[128.628246] Starting subtest: in-flight-external
[130.160281] Subtest in-flight-external: SUCCESS (1.539s)
[130.301960] [014/130] (890s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[130.398204] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[131.232284] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[131.379619] [015/130] (889s left) gem_exec_whisper (basic-fds)
[131.442892] Starting subtest: basic-fds
[138.835325] Subtest basic-fds: SUCCESS (7.411s)
[139.030624] [016/130] (881s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[139.132153] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[139.136716] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[139.221134] [017/130] (881s left) kms_cursor_crc (cursor-sliding-256x256)
[139.462161] Starting subtest: cursor-sliding-256x256
[139.464527] Starting dynamic subtest: pipe-A-eDP-1
[142.682182] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.219s)
[142.707724] Starting dynamic subtest: pipe-D-eDP-1
[146.583626] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.885s)
[146.586120] Subtest cursor-sliding-256x256: SUCCESS (7.128s)
[147.443994] [018/130] (873s left) gem_ctx_persistence (heartbeat-hang)
[147.496444] Starting subtest: heartbeat-hang
[147.501079] Subtest heartbeat-hang: SKIP (0.000s)
[147.598939] [019/130] (873s left) gem_pxp (regular-baseline-src-copy-readible)
[147.717054] Starting subtest: regular-baseline-src-copy-readible
[147.775141] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[147.912882] [020/130] (872s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[148.015219] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[155.212842] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.198s)
[155.316214] [021/130] (865s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[155.442392] Starting subtest: cursorB-vs-flipB-atomic-transitions
[155.446790] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[155.587522] [022/130] (865s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[155.660102] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[155.664191] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[155.846689] [023/130] (865s left) kms_vblank (wait-forked-hang)
[155.937575] Starting subtest: wait-forked-hang
[155.939982] Starting dynamic subtest: pipe-A-eDP-1
[182.825005] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.888s)
[182.840478] Starting dynamic subtest: pipe-D-eDP-1
[207.848407] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.031s)
[207.850741] Subtest wait-forked-hang: SUCCESS (51.923s)
[208.734150] [024/130] (812s left) kms_invalid_mode (bad-vsync-end)
[208.836886] Starting subtest: bad-vsync-end
[208.839113] Starting dynamic subtest: pipe-A-eDP-1
[209.123119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[209.133990] Starting dynamic subtest: pipe-B-eDP-1
[209.135910] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[209.145397] Starting dynamic subtest: pipe-C-eDP-1
[209.147644] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[209.156910] Starting dynamic subtest: pipe-D-eDP-1
[209.159212] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[209.161414] Subtest bad-vsync-end: SUCCESS (0.291s)
[209.965712] [025/130] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[210.062371] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[210.066658] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[210.148221] [026/130] (811s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[210.257999] Starting subtest: 4-tiled-64bpp-rotate-90
[210.277178] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[210.379766] [027/130] (810s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[210.487053] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[210.489363] Starting dynamic subtest: pipe-A-eDP-1
[210.572947] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[210.584278] Starting dynamic subtest: pipe-B-eDP-1
[211.742911] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s)
[211.747306] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.260s)
[212.969656] [028/130] (808s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[213.028167] Starting subtest: multi-wait-for-submit-unsubmitted
[213.132499] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[213.218623] [029/130] (808s left) gem_exec_params (invalid-fence-in-submit)
[213.276351] Starting subtest: invalid-fence-in-submit
[213.278871] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[213.415326] [030/130] (807s left) syncobj_timeline (wait-all-snapshot)
[213.459314] Starting subtest: wait-all-snapshot
[213.540451] Subtest wait-all-snapshot: SUCCESS (0.082s)
[213.629955] [031/130] (807s left) gem_exec_fence (nb-await)
[213.799039] Starting subtest: nb-await
[213.801517] Starting dynamic subtest: rcs0
[213.864217] Dynamic subtest rcs0: SUCCESS (0.065s)
[213.877399] Starting dynamic subtest: bcs0
[213.921674] Dynamic subtest bcs0: SUCCESS (0.056s)
[213.933576] Starting dynamic subtest: vcs0
[213.981210] Dynamic subtest vcs0: SUCCESS (0.058s)
[213.993793] Starting dynamic subtest: vcs1
[214.040862] Dynamic subtest vcs1: SUCCESS (0.058s)
[214.051365] Starting dynamic subtest: vecs0
[214.100517] Dynamic subtest vecs0: SUCCESS (0.058s)
[214.112664] Starting dynamic subtest: ccs0
[214.158607] Dynamic subtest ccs0: SUCCESS (0.057s)
[214.161417] Subtest nb-await: SUCCESS (0.360s)
[216.184271] [032/130] (805s left) kms_frontbuffer_tracking (fbc-2p-rte)
[216.282898] Starting subtest: fbc-2p-rte
[216.287433] Subtest fbc-2p-rte: SKIP (0.000s)
[216.380696] [033/130] (805s left) gem_exec_capture (capture)
[216.450351] Starting subtest: capture
[216.452825] Starting dynamic subtest: rcs0-smem
[217.278811] Dynamic subtest rcs0-smem: SUCCESS (0.825s)
[217.291451] Starting dynamic subtest: bcs0-smem
[218.096399] Dynamic subtest bcs0-smem: SUCCESS (0.817s)
[218.108320] Starting dynamic subtest: vcs0-smem
[218.917067] Dynamic subtest vcs0-smem: SUCCESS (0.820s)
[218.927523] Starting dynamic subtest: vcs1-smem
[219.739123] Dynamic subtest vcs1-smem: SUCCESS (0.821s)
[219.751170] Starting dynamic subtest: vecs0-smem
[221.121845] Dynamic subtest vecs0-smem: FAIL (1.328s)
[221.131818] Starting dynamic subtest: ccs0-smem
[222.385120] Dynamic subtest ccs0-smem: SUCCESS (1.319s)
[222.387359] Subtest capture: FAIL (5.932s)
[222.495402] [034/130] (799s left) kms_properties (colorop-properties-atomic)
[222.599153] Starting subtest: colorop-properties-atomic
[222.601193] Starting dynamic subtest: pipe-A-eDP-1
[222.963501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.363s)
[222.975364] Starting dynamic subtest: pipe-B-eDP-1
[224.003685] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.039s)
[224.014637] Starting dynamic subtest: pipe-C-eDP-1
[225.037290] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.034s)
[225.048119] Starting dynamic subtest: pipe-D-eDP-1
[226.077255] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.038s)
[226.079633] Subtest colorop-properties-atomic: SUCCESS (3.478s)
[226.885730] [035/130] (794s left) gem_eio (in-flight-internal-10ms)
[227.056991] Starting subtest: in-flight-internal-10ms
[228.132421] Subtest in-flight-internal-10ms: SUCCESS (1.076s)
[228.296049] [036/130] (793s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[228.384763] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[228.386979] Starting dynamic subtest: pipe-A
[228.449527] Dynamic subtest pipe-A: SUCCESS (0.064s)
[228.460036] Starting dynamic subtest: pipe-B
[229.595347] Dynamic subtest pipe-B: SUCCESS (1.145s)
[229.608130] Starting dynamic subtest: pipe-C
[230.706381] Dynamic subtest pipe-C: SUCCESS (1.109s)
[230.715800] Starting dynamic subtest: pipe-D
[231.833833] Dynamic subtest pipe-D: SUCCESS (1.127s)
[231.836154] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.449s)
[232.996864] [037/130] (788s left) syncobj_timeline (invalid-signal-bad-pad)
[233.050704] Starting subtest: invalid-signal-bad-pad
[233.053032] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[233.162088] [038/130] (788s left) i915_drm_fdinfo (busy)
[233.206294] Starting subtest: busy
[233.208777] Starting dynamic subtest: rcs0
[233.238772] Dynamic subtest rcs0: SKIP (0.035s)
[233.249065] Starting dynamic subtest: bcs0
[233.253289] Dynamic subtest bcs0: SKIP (0.000s)
[233.262443] Starting dynamic subtest: vcs0
[233.266888] Dynamic subtest vcs0: SKIP (0.000s)
[233.275857] Starting dynamic subtest: vcs1
[233.279857] Dynamic subtest vcs1: SKIP (0.000s)
[233.288558] Starting dynamic subtest: vecs0
[233.292714] Dynamic subtest vecs0: SKIP (0.000s)
[233.301430] Starting dynamic subtest: ccs0
[233.306079] Dynamic subtest ccs0: SKIP (0.000s)
[233.310173] Subtest busy: SKIP (0.040s)
[233.360375] [039/130] (788s left) kms_async_flips (alternate-sync-async-flip)
[233.459477] Starting subtest: alternate-sync-async-flip
[233.834194] Starting dynamic subtest: pipe-A-eDP-1
[236.586165] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.754s)
[236.975883] Starting dynamic subtest: pipe-B-eDP-1
[239.722177] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[240.097894] Starting dynamic subtest: pipe-C-eDP-1
[242.852602] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[243.226642] Starting dynamic subtest: pipe-D-eDP-1
[245.980537] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.762s)
[245.982521] Subtest alternate-sync-async-flip: SUCCESS (12.524s)
[247.149467] [040/130] (774s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[247.257510] Starting subtest: yf-tiled-16bpp-rotate-90
[247.262113] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[247.366941] [041/130] (774s left) gem_ctx_param (invalid-ctx-set)
[247.426191] Starting subtest: invalid-ctx-set
[247.428849] Subtest invalid-ctx-set: SUCCESS (0.002s)
[247.522345] [042/130] (774s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[247.617662] Starting subtest: y-tiled-8bpp-rotate-270
[247.621902] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[247.737654] [043/130] (774s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[247.824407] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[247.827122] Starting dynamic subtest: pipe-A-eDP-1
[247.848230] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[247.861109] Starting dynamic subtest: pipe-B-eDP-1
[247.880981] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[247.889978] Starting dynamic subtest: pipe-C-eDP-1
[247.909559] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[247.918636] Starting dynamic subtest: pipe-D-eDP-1
[247.938212] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[247.940458] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[250.009255] [044/130] (771s left) gem_mmap_gtt (fault-concurrent-x)
[250.077798] Subtest fault-concurrent-X: SKIP (0.000s)
[250.144304] [045/130] (771s left) kms_pm_backlight (brightness-with-dpms)
[250.239757] Starting subtest: brightness-with-dpms
[250.290320] Starting dynamic subtest: eDP-1
[252.806767] Dynamic subtest eDP-1: SUCCESS (2.517s)
[252.809003] Subtest brightness-with-dpms: SUCCESS (2.567s)
[253.666225] [046/130] (768s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[253.753458] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[253.755678] Starting dynamic subtest: pipe-A-default-mode
[256.488216] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[256.490163] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.735s)
[257.355814] [047/130] (764s left) i915_hangman (gt-error-state-capture)
[257.424290] Starting subtest: gt-error-state-capture
[257.426606] Starting dynamic subtest: rcs0
[269.062885] Dynamic subtest rcs0: SUCCESS (11.638s)
[269.075547] Starting dynamic subtest: bcs0
[281.093834] Dynamic subtest bcs0: SUCCESS (12.030s)
[281.106668] Starting dynamic subtest: vcs0
[293.062478] Dynamic subtest vcs0: SUCCESS (11.968s)
[293.075171] Starting dynamic subtest: vcs1
[305.030062] Dynamic subtest vcs1: SUCCESS (11.967s)
[305.043336] Starting dynamic subtest: vecs0
[316.998041] Dynamic subtest vecs0: SUCCESS (11.968s)
[317.010767] Starting dynamic subtest: ccs0
[328.071446] Dynamic subtest ccs0: SUCCESS (11.073s)
[328.074091] Subtest gt-error-state-capture: SUCCESS (70.660s)
[328.152204] [048/130] (693s left) kms_atomic_transition (plane-toggle-modeset-transition)
[328.248476] Starting subtest: plane-toggle-modeset-transition
[328.250352] Starting dynamic subtest: pipe-A-eDP-1
[340.990405] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.741s)
[341.004452] Starting dynamic subtest: pipe-B-eDP-1
[353.466271] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.468s)
[353.468844] Subtest plane-toggle-modeset-transition: SUCCESS (25.216s)
[354.296739] [049/130] (667s left) kms_psr (fbc-psr-suspend)
[354.397873] Starting subtest: fbc-psr-suspend
[354.400099] Starting dynamic subtest: eDP-1
[354.404576] Dynamic subtest eDP-1: SKIP (0.000s)
[354.409050] Subtest fbc-psr-suspend: SKIP (0.001s)
[354.470728] [050/130] (667s left) gem_partial_pwrite_pread (write-uncached)
[354.522246] Subtest write-uncached: SKIP (0.000s)
[354.590426] [051/130] (667s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[354.679718] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[354.681881] Starting dynamic subtest: pipe-A-eDP-1
[354.701601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[354.713195] Starting dynamic subtest: pipe-B-eDP-1
[354.732052] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[354.741580] Starting dynamic subtest: pipe-C-eDP-1
[354.759835] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[354.771303] Starting dynamic subtest: pipe-D-eDP-1
[354.790436] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[354.792647] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[356.893920] [052/130] (665s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[357.164408] Starting subtest: cursor-rapid-movement-512x512
[357.168877] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[357.326287] [053/130] (664s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[357.425925] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[357.430097] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[357.520263] [054/130] (664s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[357.884817] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[358.680015] [055/130] (663s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[358.769911] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[358.772246] Starting dynamic subtest: pipe-A-eDP-1
[358.796004] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[358.808270] Starting dynamic subtest: pipe-B-eDP-1
[358.830533] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[358.840745] Starting dynamic subtest: pipe-C-eDP-1
[358.862647] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[358.872197] Starting dynamic subtest: pipe-D-eDP-1
[358.894290] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[358.898431] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[361.067388] [056/130] (661s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[361.175804] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[361.180384] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[361.304176] [057/130] (661s left) kms_sequence (get-idle)
[361.394811] Starting subtest: get-idle
[361.397144] Starting dynamic subtest: pipe-A-eDP-1
[363.207884] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[363.218378] Starting dynamic subtest: pipe-B-eDP-1
[365.649523] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.441s)
[365.663369] Starting dynamic subtest: pipe-C-eDP-1
[368.075385] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.421s)
[368.085543] Starting dynamic subtest: pipe-D-eDP-1
[370.507937] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.434s)
[370.510376] Subtest get-idle: SUCCESS (9.113s)
[371.306694] [058/130] (651s left) gem_render_copy (linear)
[371.372529] Starting subtest: linear
[371.374692] Starting dynamic subtest: smem
[371.412675] Dynamic subtest smem: SUCCESS (0.042s)
[371.415231] Subtest linear: SUCCESS (0.043s)
[371.610995] [059/130] (650s left) gem_close_race (multigpu-basic-threads)
[371.686503] Starting subtest: multigpu-basic-threads
[371.691314] Subtest multigpu-basic-threads: SKIP (0.000s)
[371.904246] [060/130] (650s left) i915_suspend (fence-restore-untiled)
[371.963363] Starting subtest: fence-restore-untiled
[371.967710] Subtest fence-restore-untiled: SKIP (0.000s)
[372.082277] [061/130] (650s left) gem_basic (bad-close)
[372.142109] Starting subtest: bad-close
[372.146492] Subtest bad-close: SUCCESS (0.000s)
[372.265100] [062/130] (650s left) kms_atomic_transition (plane-all-transition-fencing)
[372.355735] Starting subtest: plane-all-transition-fencing
[372.357938] Starting dynamic subtest: pipe-A-eDP-1
[374.853728] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[375.158839] Starting dynamic subtest: pipe-B-eDP-1
[378.350480] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.203s)
[378.652214] Subtest plane-all-transition-fencing: SUCCESS (6.295s)
[379.480385] [063/130] (643s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[379.581090] Starting subtest: fb-8bpc-vs-panel-6bpc
[379.583420] Starting dynamic subtest: pipe-A-eDP-1
[380.939353] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.357s)
[380.941627] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.359s)
[381.733428] [064/130] (641s left) kms_tv_load_detect (load-detect)
[381.808631] Subtest load-detect: SKIP (0.000s)
[381.871845] [065/130] (640s left) gen9_exec_parse (allowed-single)
[381.926976] Subtest allowed-single: SKIP (0.000s)
[381.992149] [066/130] (640s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[382.079798] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[382.083882] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[382.152638] [067/130] (640s left) perf (stress-open-close)
[382.277717] Starting subtest: stress-open-close
[382.279880] Starting dynamic subtest: 0-rcs0
[384.444003] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[384.455209] Starting dynamic subtest: 1-vecs0
[386.605569] Dynamic subtest 1-vecs0: SUCCESS (2.160s)
[386.607616] Subtest stress-open-close: SUCCESS (4.329s)
[386.654655] [068/130] (636s left) api_intel_allocator (open-vm)
[386.716159] Starting subtest: open-vm
[386.718196] Subtest open-vm: SUCCESS (0.003s)
[386.844344] [069/130] (636s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[386.940741] Starting subtest: psr-rgb101010-draw-mmap-wc
[394.032742] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.093s)
[394.131958] [070/130] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[394.254113] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[394.258563] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[394.344825] [071/130] (628s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[394.416160] Starting subtest: multi-wait-for-submit-submitted-signaled
[394.418520] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[394.509296] [072/130] (628s left) kms_content_protection (atomic-dpms-hdcp14)
[394.646488] Starting subtest: atomic-dpms-hdcp14
[394.651049] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[394.784489] [073/130] (628s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[394.868932] Starting subtest: fbc-psr-cursor-mmap-gtt
[394.871178] Starting dynamic subtest: eDP-1
[394.875625] Dynamic subtest eDP-1: SKIP (0.000s)
[394.880051] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[394.943019] [074/130] (628s left) syncobj_wait (multi-wait-all-submitted-signaled)
[395.011387] Starting subtest: multi-wait-all-submitted-signaled
[395.116921] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[395.195023] [075/130] (628s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[395.298255] Starting subtest: x-tiled-64bpp-rotate-270
[395.321213] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[395.432505] [076/130] (627s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[395.529217] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[395.533405] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[395.612021] [077/130] (627s left) kms_flip (blocking-wf_vblank)
[395.729643] Starting subtest: blocking-wf_vblank
[395.731756] Starting dynamic subtest: A-eDP1
[404.649606] Dynamic subtest A-eDP1: SUCCESS (8.889s)
[404.659108] Starting dynamic subtest: B-eDP1
[413.583802] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[413.596027] Starting dynamic subtest: C-eDP1
[422.519462] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[422.531098] Starting dynamic subtest: D-eDP1
[431.395413] Dynamic subtest D-eDP1: SUCCESS (8.917s)
[431.401655] Subtest blocking-wf_vblank: SUCCESS (35.674s)
[432.626823] [078/130] (590s left) gem_mmap_gtt (basic-small-copy-odd)
[432.691639] Subtest basic-small-copy-odd: SKIP (0.000s)
[432.756938] [079/130] (590s left) kms_dsc (dsc-with-bpc-formats)
[432.843815] Starting subtest: dsc-with-bpc-formats
[432.951166] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[432.994986] [080/130] (590s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[433.092245] Starting subtest: psr2-cursor-plane-update-sf
[433.094688] Starting dynamic subtest: pipe-A-eDP-1
[433.652393] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[433.664098] Starting dynamic subtest: pipe-B-eDP-1
[434.899015] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.243s)
[434.901042] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.811s)
[435.783095] [081/130] (587s left) kms_plane (pixel-format-yf-tiled-modifier)
[435.875303] Starting subtest: pixel-format-yf-tiled-modifier
[435.879781] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[435.960514] [082/130] (587s left) gen3_mixed_blits
[436.116708] [083/130] (587s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[436.177344] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[436.284687] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[436.373806] [084/130] (587s left) gem_mmap_gtt (pf-nonblock)
[436.433027] Subtest pf-nonblock: SKIP (0.000s)
[436.497757] [085/130] (587s left) kms_plane_lowres (tiling-4)
[436.587832] Starting subtest: tiling-4
[436.590139] Starting dynamic subtest: pipe-A-eDP-1
[436.594636] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[436.881973] Starting dynamic subtest: pipe-B-eDP-1
[436.886633] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[436.896834] Starting dynamic subtest: pipe-C-eDP-1
[436.901375] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[436.911151] Starting dynamic subtest: pipe-D-eDP-1
[436.915611] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[436.919959] Subtest tiling-4: SKIP (0.292s)
[437.725357] [086/130] (586s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[437.831716] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[437.836097] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[437.934406] [087/130] (585s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[438.023849] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[438.026156] Starting dynamic subtest: pipe-A-eDP-1
[438.035218] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[438.050158] Starting dynamic subtest: pipe-B-eDP-1
[438.058181] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[438.067557] Starting dynamic subtest: pipe-C-eDP-1
[438.075638] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[438.084724] Starting dynamic subtest: pipe-D-eDP-1
[438.092715] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[438.096689] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[440.281981] [088/130] (583s left) perf_pmu (render-node-busy)
[440.344881] Starting subtest: render-node-busy
[440.347334] Starting dynamic subtest: rcs0
[440.924342] Dynamic subtest rcs0: SUCCESS (0.579s)
[440.936793] Starting dynamic subtest: bcs0
[441.483505] Dynamic subtest bcs0: SUCCESS (0.557s)
[441.495863] Starting dynamic subtest: vcs0
[443.112934] Dynamic subtest vcs0: SUCCESS (1.625s)
[443.124276] Starting dynamic subtest: vcs1
[445.096931] Dynamic subtest vcs1: SUCCESS (1.981s)
[445.108552] Starting dynamic subtest: vecs0
[447.081413] Dynamic subtest vecs0: SUCCESS (1.981s)
[447.093389] Starting dynamic subtest: ccs0
[447.644787] Dynamic subtest ccs0: SUCCESS (0.561s)
[447.647655] Subtest render-node-busy: SUCCESS (7.301s)
[447.737081] [089/130] (576s left) dumb_buffer (map-uaf)
[447.793945] Starting subtest: map-uaf
[447.796226] Subtest map-uaf: SUCCESS (0.004s)
[447.901111] [090/130] (576s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[447.955248] Subtest writes-after-reads-uncached: SKIP (0.000s)
[448.025358] [091/130] (575s left) kms_cursor_crc (cursor-onscreen-max-size)
[448.329984] Starting subtest: cursor-onscreen-max-size
[448.336665] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[448.440183] [092/130] (575s left) gem_mmap_gtt (big-copy-odd)
[448.497188] Subtest big-copy-odd: SKIP (0.000s)
[448.555007] [093/130] (575s left) gem_pread (bench)
[448.611144] Subtest bench: SKIP (0.000s)
[448.670426] [094/130] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[448.761468] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[448.765417] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[448.856877] [095/130] (575s left) syncobj_timeline (wait-delayed-signal)
[448.918948] Starting subtest: wait-delayed-signal
[449.022446] Subtest wait-delayed-signal: SUCCESS (0.102s)
[449.115514] [096/130] (575s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[449.216735] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[449.220668] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[449.306306] [097/130] (574s left) kms_lease (master-vs-lease)
[449.396468] Starting subtest: master-vs-lease
[449.398711] Subtest master-vs-lease: SUCCESS (0.002s)
[449.503795] [098/130] (574s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[449.595803] Starting subtest: compare-crc-sanitycheck-nv12
[449.597914] Starting dynamic subtest: pipe-A-eDP-1
[450.263461] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.667s)
[450.274201] Starting dynamic subtest: pipe-B-eDP-1
[451.523017] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.260s)
[451.534044] Starting dynamic subtest: pipe-C-eDP-1
[452.707719] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.182s)
[452.721577] Starting dynamic subtest: pipe-D-eDP-1
[453.989434] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s)
[453.991719] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.395s)
[454.810264] [099/130] (569s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[454.911320] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[461.660130] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.752s)
[461.775370] [100/130] (562s left) kms_getfb (getfb2-into-addfb2)
[461.867776] Starting subtest: getfb2-into-addfb2
[461.870060] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[461.968451] [101/130] (562s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[462.017173] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[462.124835] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[462.203938] [102/130] (562s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[462.322275] Starting subtest: flip-vs-cursor-crc-legacy
[463.004185] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.681s)
[463.876017] [103/130] (560s left) syncobj_wait (multi-wait-submitted-signaled)
[463.936409] Starting subtest: multi-wait-submitted-signaled
[463.938626] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[464.030353] [104/130] (560s left) api_intel_bb (offset-control)
[464.085775] Starting subtest: offset-control
[464.090830] Subtest offset-control: SUCCESS (0.007s)
[464.203509] [105/130] (560s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[464.295848] Starting subtest: plane-primary-toggle-with-vblank-wait
[464.298180] Starting dynamic subtest: pipe-A-eDP-1
[464.468266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[464.779299] Starting dynamic subtest: pipe-B-eDP-1
[465.667526] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.896s)
[465.967686] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.673s)
[466.828229] [106/130] (557s left) gem_render_copy_redux (interruptible)
[466.880837] Starting subtest: interruptible
[467.181475] Subtest interruptible: SUCCESS (0.304s)
[467.287912] [107/130] (557s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[467.393229] Starting subtest: psr-2p-primscrn-cur-indfb-move
[467.397369] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[467.488100] [108/130] (557s left) gem_exec_balancer (parallel-balancer)
[467.757931] Starting subtest: parallel-balancer
[468.623316] Subtest parallel-balancer: SUCCESS (0.866s)
[468.719717] [109/130] (556s left) gem_ctx_isolation (preservation-s3)
[468.774977] Starting subtest: preservation-S3
[468.777174] Starting dynamic subtest: rcs0
[484.891105] Dynamic subtest rcs0: SUCCESS (1.305s)
[484.902442] Starting dynamic subtest: bcs0
[500.910671] Dynamic subtest bcs0: SUCCESS (1.341s)
[500.921650] Starting dynamic subtest: vcs0
[516.891289] Dynamic subtest vcs0: SUCCESS (2.719s)
[516.904287] Starting dynamic subtest: vcs1
[534.919160] Dynamic subtest vcs1: SUCCESS (5.060s)
[534.929516] Starting dynamic subtest: vecs0
[552.915037] Dynamic subtest vecs0: SUCCESS (4.982s)
[552.927977] Starting dynamic subtest: ccs0
[570.889970] Dynamic subtest ccs0: SUCCESS (3.240s)
[570.892559] Subtest preservation-S3: SUCCESS (18.652s)
[571.122964] [110/130] (453s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[571.212912] Starting subtest: random-ccs-data-yf-tiled-ccs
[571.215213] Starting dynamic subtest: pipe-A-eDP-1
[571.241562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[571.251116] Starting dynamic subtest: pipe-B-eDP-1
[571.277776] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[571.287356] Starting dynamic subtest: pipe-C-eDP-1
[571.313650] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[571.322973] Starting dynamic subtest: pipe-D-eDP-1
[571.351182] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[571.356203] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[573.405506] [111/130] (451s left) gem_exec_parallel (fds)
[573.476725] Starting subtest: fds
[573.479310] Starting dynamic subtest: rcs0
[576.867905] Dynamic subtest rcs0: SUCCESS (3.451s)
[576.883909] Starting dynamic subtest: bcs0
[581.510382] Dynamic subtest bcs0: SUCCESS (4.692s)
[581.525212] Starting dynamic subtest: vcs0
[585.875687] Dynamic subtest vcs0: SUCCESS (4.390s)
[585.887197] Starting dynamic subtest: vcs1
[589.844866] Dynamic subtest vcs1: SUCCESS (3.981s)
[589.858499] Starting dynamic subtest: vecs0
[593.954965] Dynamic subtest vecs0: SUCCESS (4.118s)
[593.966187] Starting dynamic subtest: ccs0
[599.114027] Dynamic subtest ccs0: SUCCESS (5.165s)
[599.117073] Subtest fds: SUCCESS (25.809s)
[599.319069] [112/130] (425s left) gem_userptr_blits (probe)
[599.397081] Starting subtest: probe
[599.471671] Subtest probe: SUCCESS (0.075s)
[599.588425] [113/130] (425s left) gem_exec_schedule (semaphore-codependency)
[599.654401] Starting subtest: semaphore-codependency
[599.669800] Subtest semaphore-codependency: SUCCESS (0.022s)
[600.004612] [114/130] (424s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[600.094003] Starting subtest: plane-use-after-nonblocking-unbind
[600.096621] Starting dynamic subtest: pipe-A-eDP-1
[600.158808] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[600.463650] Starting dynamic subtest: pipe-B-eDP-1
[601.228190] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.779s)
[601.521986] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.431s)
[602.394034] [115/130] (422s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[602.505855] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[609.070236] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.562s)
[609.196734] [116/130] (415s left) drm_read (short-buffer-wakeup)
[609.338971] Starting subtest: short-buffer-wakeup
[641.554960] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[641.700788] [117/130] (383s left) gem_exec_whisper (basic-sync-all)
[641.767095] Starting subtest: basic-sync-all
[649.182456] Subtest basic-sync-all: SUCCESS (7.414s)
[649.369401] [118/130] (375s left) i915_pm_rpm (gem-execbuf)
[650.913414] Starting subtest: gem-execbuf
[650.916366] Starting dynamic subtest: smem0
[653.001808] Dynamic subtest smem0: SUCCESS (2.088s)
[653.004191] Subtest gem-execbuf: SUCCESS (2.089s)
[653.092449] [119/130] (372s left) kms_hdmi_inject (inject-4k)
[653.445635] Starting subtest: inject-4k
[653.760693] Subtest inject-4k: SUCCESS (0.317s)
[654.321893] [120/130] (370s left) kms_color (invalid-gamma-lut-sizes)
[654.427807] Starting subtest: invalid-gamma-lut-sizes
[654.430108] Starting dynamic subtest: pipe-A
[654.711984] Dynamic subtest pipe-A: SUCCESS (0.286s)
[654.723215] Starting dynamic subtest: pipe-B
[654.725652] Dynamic subtest pipe-B: SUCCESS (0.000s)
[654.735493] Starting dynamic subtest: pipe-C
[654.737789] Dynamic subtest pipe-C: SUCCESS (0.000s)
[654.748049] Starting dynamic subtest: pipe-D
[654.750458] Dynamic subtest pipe-D: SUCCESS (0.000s)
[654.752679] Subtest invalid-gamma-lut-sizes: SUCCESS (0.289s)
[655.589556] [121/130] (369s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[655.684995] Starting subtest: multiplane-rotation-cropping-bottom
[673.224673] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.540s)
[673.340282] [122/130] (351s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[673.435777] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[673.439709] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[673.575618] [123/130] (351s left) syncobj_wait (invalid-reset-one-illegal-handle)
[673.638762] Starting subtest: invalid-reset-one-illegal-handle
[673.640964] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[673.736647] [124/130] (351s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[674.118209] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[674.965022] [125/130] (350s left) syncobj_basic (bad-create-flags)
[675.022204] Starting subtest: bad-create-flags
[675.025018] Subtest bad-create-flags: SUCCESS (0.000s)
[675.131164] [126/130] (350s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[675.228233] Starting subtest: fbc-pr-sprite-mmap-cpu
[675.233619] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[675.306959] [127/130] (350s left) kms_vrr (flipline)
[675.400363] Starting subtest: flipline
[675.408689] Subtest flipline: SKIP (0.000s)
[675.488637] [128/130] (350s left) kms_psr (psr-basic)
[675.578078] Starting subtest: psr-basic
[675.580568] Starting dynamic subtest: eDP-1
[677.235241] Dynamic subtest eDP-1: SUCCESS (1.655s)
[677.238133] Subtest psr-basic: SUCCESS (1.656s)
[678.087778] [129/130] (347s left) kms_atomic (plane-primary-legacy)
[678.172608] Starting subtest: plane-primary-legacy
[678.174871] Starting dynamic subtest: pipe-A-eDP-1
[678.637059] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s)
[678.639863] Subtest plane-primary-legacy: SUCCESS (0.464s)
[679.482588] [130/130] (346s left) prime_mmap (test_reprime)
[679.535710] Starting subtest: test_reprime
[679.537940] Starting dynamic subtest: test_reprime-smem
[679.567006] Dynamic subtest test_reprime-smem: SUCCESS (0.034s)
[679.569930] Subtest test_reprime: SUCCESS (0.035s)
[679.662789] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: prime_vgem
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_softpin
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_nop
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: vgem_slow
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_eio
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_exec_whisper
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: gem_ctx_persistence
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: kms_invalid_mode
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_capture
results: parsing output: 33/ for test: kms_properties
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: kms_async_flips
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_ctx_param
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: kms_pm_backlight
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: i915_hangman
results: parsing output: 47/ for test: kms_atomic_transition
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_partial_pwrite_pread
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_chamelium_edid
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_sequence
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: gem_close_race
results: parsing output: 59/ for test: i915_suspend
results: parsing output: 60/ for test: gem_basic
results: parsing output: 61/ for test: kms_atomic_transition
results: parsing output: 62/ for test: kms_dither
results: parsing output: 63/ for test: kms_tv_load_detect
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_content_protection
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: kms_dsc
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: gen3_mixed_blits
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_plane_lowres
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: dumb_buffer
results: parsing output: 89/ for test: gem_partial_pwrite_pread
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: gem_pread
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_lease
results: parsing output: 97/ for test: kms_pipe_crc_basic
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_getfb
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_atomic_transition
results: parsing output: 105/ for test: gem_render_copy_redux
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: gem_ctx_isolation
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_exec_parallel
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_atomic_transition
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: drm_read
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: i915_pm_rpm
results: parsing output: 118/ for test: kms_hdmi_inject
results: parsing output: 119/ for test: kms_color
results: parsing output: 120/ for test: kms_rotation_crc
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_chamelium_hpd
results: parsing output: 124/ for test: syncobj_basic
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_vrr
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_atomic
results: parsing output: 129/ for test: prime_mmap
Done.