[55.933905] Initializing watchdogs
[55.933963]   /dev/watchdog0
[55.948753] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[55.953475] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.955909] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.959317] [001/156] (960s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[56.083327] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[56.087271] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[56.175226] [002/156] (960s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[56.279235] Starting subtest: fbc-indfb-scaledprimary
[59.149387] Subtest fbc-indfb-scaledprimary: SUCCESS (2.891s)
[60.280746] [003/156] (956s left) kms_psr (fbc-pr-cursor-blt)
[60.384668] Starting subtest: fbc-pr-cursor-blt
[60.389213] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[60.451616] [004/156] (956s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt)
[60.561233] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt
[60.565281] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[60.660813] [005/156] (955s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[60.713918] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[60.718310] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[60.897211] [006/156] (955s left) gem_mmap_offset (partial-unmap)
[60.955747] Starting subtest: partial-unmap
[60.957952] Starting dynamic subtest: smem0
[61.458775] Dynamic subtest smem0: SUCCESS (0.505s)
[61.461483] Subtest partial-unmap: SUCCESS (0.506s)
[61.581902] [007/156] (955s left) gem_mmap_wc (coherency)
[61.633186] Subtest coherency: SKIP (0.000s)
[61.692308] [008/156] (955s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[61.802651] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[61.806819] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[61.896277] [009/156] (954s left) gem_exec_schedule (u-fairslice)
[61.965595] Starting subtest: u-fairslice
[61.967773] Starting dynamic subtest: rcs0
[63.990964] Dynamic subtest rcs0: SUCCESS (2.035s)
[63.998198] Starting dynamic subtest: bcs0
[66.014932] Dynamic subtest bcs0: SUCCESS (2.028s)
[66.023104] Starting dynamic subtest: vcs0
[68.089572] Dynamic subtest vcs0: SUCCESS (2.028s)
[68.098246] Starting dynamic subtest: vcs1
[70.063777] Dynamic subtest vcs1: SUCCESS (2.023s)
[70.075734] Starting dynamic subtest: vecs0
[72.131717] Dynamic subtest vecs0: SUCCESS (2.022s)
[72.140151] Starting dynamic subtest: ccs0
[74.107670] Dynamic subtest ccs0: SUCCESS (2.025s)
[74.109697] Subtest u-fairslice: SUCCESS (12.164s)
[74.407946] [010/156] (942s left) sw_sync (sync_busy)
[74.448904] Starting subtest: sync_busy
[74.451437] Subtest sync_busy: SUCCESS (0.002s)
[74.504846] [011/156] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[74.610090] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[81.424392] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.824s)
[81.544802] [012/156] (935s left) gem_spin_batch (legacy-resubmit)
[81.612549] Starting subtest: legacy-resubmit
[81.614892] Starting dynamic subtest: default
[81.619659] Dynamic subtest default: SUCCESS (0.006s)
[81.629225] Starting dynamic subtest: render
[81.631493] Dynamic subtest render: SUCCESS (0.002s)
[81.638750] Starting dynamic subtest: bsd
[81.640661] Dynamic subtest bsd: SUCCESS (0.002s)
[81.647548] Starting dynamic subtest: bsd1
[81.649461] Dynamic subtest bsd1: SUCCESS (0.002s)
[81.656412] Starting dynamic subtest: bsd2
[81.658341] Dynamic subtest bsd2: SUCCESS (0.001s)
[81.665115] Starting dynamic subtest: blt
[81.667037] Dynamic subtest blt: SUCCESS (0.002s)
[81.673703] Starting dynamic subtest: vebox
[81.675639] Dynamic subtest vebox: SUCCESS (0.002s)
[81.677568] Subtest legacy-resubmit: SUCCESS (0.021s)
[81.851627] [013/156] (935s left) fbdev (unaligned-write)
[81.896357] Starting subtest: unaligned-write
[81.994466] Subtest unaligned-write: SUCCESS (0.100s)
[82.051888] [014/156] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[82.150479] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[82.155230] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[82.240915] [015/156] (934s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[82.350861] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[82.355315] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[82.455730] [016/156] (934s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[82.604772] Starting subtest: dp-mst-type-0-suspend-resume
[82.609497] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[82.720396] [017/156] (934s left) gem_exec_fence (submit-chain)
[82.889776] Starting subtest: submit-chain
[82.908739] Subtest submit-chain: SUCCESS (0.020s)
[84.364602] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[84.367932] [018/156] (932s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[84.467152] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[84.471444] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[84.555867] [019/156] (932s left) gem_eio (wait-wedge-immediate)
[84.774243] Starting subtest: wait-wedge-immediate
[86.342246] Subtest wait-wedge-immediate: SUCCESS (1.567s)
[86.481156] [020/156] (930s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[86.576829] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[86.581494] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[86.660068] [021/156] (930s left) kms_addfb_basic (unused-handle)
[86.719932] Starting subtest: unused-handle
[86.722403] Subtest unused-handle: SUCCESS (0.000s)
[86.852411] [022/156] (930s left) sriov_basic (enable-vfs-bind-unbind-each)
[86.922242] Starting subtest: enable-vfs-bind-unbind-each
[86.924544] Starting dynamic subtest: numvfs-1
[87.001339] Dynamic subtest numvfs-1: FAIL (0.017s)
[87.011519] Starting dynamic subtest: numvfs-2
[87.085680] Dynamic subtest numvfs-2: FAIL (0.004s)
[87.096204] Starting dynamic subtest: numvfs-3
[87.170168] Dynamic subtest numvfs-3: FAIL (0.004s)
[87.181974] Starting dynamic subtest: numvfs-4
[87.252267] Dynamic subtest numvfs-4: FAIL (0.003s)
[87.260397] Starting dynamic subtest: numvfs-5
[87.318202] Dynamic subtest numvfs-5: FAIL (0.003s)
[87.325866] Starting dynamic subtest: numvfs-6
[87.385883] Dynamic subtest numvfs-6: FAIL (0.003s)
[87.394540] Starting dynamic subtest: numvfs-7
[87.455746] Dynamic subtest numvfs-7: FAIL (0.003s)
[87.465516] Starting dynamic subtest: numvfs-random
[87.524643] Dynamic subtest numvfs-random: FAIL (0.003s)
[87.526492] Subtest enable-vfs-bind-unbind-each: FAIL (0.044s)
[87.561786] [023/156] (929s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[87.655978] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[87.659599] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[87.724455] [024/156] (929s left) gem_ctx_persistence (engines-mixed-process)
[87.777558] Starting subtest: engines-mixed-process
[87.779605] Starting dynamic subtest: rcs0
[89.285674] Dynamic subtest rcs0: SUCCESS (1.508s)
[89.296622] Starting dynamic subtest: bcs0
[91.313351] Dynamic subtest bcs0: SUCCESS (2.026s)
[91.323563] Starting dynamic subtest: vcs0
[93.325754] Dynamic subtest vcs0: SUCCESS (2.013s)
[93.336783] Starting dynamic subtest: vcs1
[95.306339] Dynamic subtest vcs1: SUCCESS (1.979s)
[95.315920] Starting dynamic subtest: vecs0
[97.305097] Dynamic subtest vecs0: SUCCESS (1.998s)
[97.316455] Starting dynamic subtest: ccs0
[99.317519] Dynamic subtest ccs0: SUCCESS (2.010s)
[99.320144] Subtest engines-mixed-process: SUCCESS (11.538s)
[99.418119] [025/156] (917s left) gem_ctx_param (invalid-size-set)
[99.476599] Starting subtest: invalid-size-set
[99.478934] Subtest invalid-size-set: SUCCESS (0.001s)
[99.610747] [026/156] (917s left) gem_caching (read-writes)
[99.675119] Subtest read-writes: SKIP (0.000s)
[99.744911] [027/156] (917s left) gem_userptr_blits (unsync-overlap)
[99.809569] Subtest unsync-overlap: SKIP (0.000s)
[99.915249] [028/156] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[100.013406] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[100.017848] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[100.105953] [029/156] (917s left) i915_pm_rpm (sysfs-read)
[101.670630] Starting subtest: sysfs-read
[102.824965] Subtest sysfs-read: SUCCESS (1.156s)
[103.248954] [030/156] (914s left) gem_watchdog (default-virtual)
[103.332684] Starting subtest: default-virtual
[109.364087] Subtest default-virtual: SUCCESS (6.042s)
[109.454765] [031/156] (908s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[109.556461] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[109.560575] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[109.654902] [032/156] (908s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[109.783108] Starting subtest: cursorB-vs-flipA-legacy
[109.787718] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[109.952296] [033/156] (907s left) gem_ctx_engines (invalid-engines)
[110.007871] Starting subtest: invalid-engines
[110.015114] Subtest invalid-engines: SUCCESS (0.009s)
[110.248435] [034/156] (907s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[110.338631] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[110.342804] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[110.446758] [035/156] (907s left) gem_ctx_sseu (invalid-sseu)
[110.508476] Subtest invalid-sseu: SKIP (0.000s)
[110.573678] [036/156] (907s left) syncobj_timeline (invalid-transfer-non-existent-point)
[110.628666] Starting subtest: invalid-transfer-non-existent-point
[110.631044] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[110.719825] [037/156] (907s left) gem_softpin (noreloc-s3)
[110.790816] Starting subtest: noreloc-S3
[130.823164] Subtest noreloc-S3: SUCCESS (5.425s)
[130.935825] [038/156] (887s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[131.053263] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[131.057639] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[131.179253] [039/156] (886s left) gem_exec_balancer (invalid-balancer)
[131.238240] Starting subtest: invalid-balancer
[132.139744] Subtest invalid-balancer: SUCCESS (0.906s)
[132.431175] [040/156] (885s left) kms_big_fb (linear-addfb)
[132.524430] Starting subtest: linear-addfb
[132.526338] Subtest linear-addfb: SUCCESS (0.000s)
[132.617932] [041/156] (885s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[132.715761] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[132.720614] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[132.813999] [042/156] (885s left) syncobj_wait (invalid-signal-bad-pad)
[132.875943] Starting subtest: invalid-signal-bad-pad
[132.878190] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[132.983304] [043/156] (885s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[133.083248] Starting subtest: 4-tiled-16bpp-rotate-270
[133.102531] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[133.206591] [044/156] (885s left) kms_plane_alpha_blend (alpha-7efc)
[133.289782] Starting subtest: alpha-7efc
[133.570022] Starting dynamic subtest: pipe-A-eDP-1
[134.175578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[134.208668] Starting dynamic subtest: pipe-D-eDP-1
[135.451432] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.256s)
[135.454021] Subtest alpha-7efc: SUCCESS (2.171s)
[136.324487] [045/156] (881s left) kms_psr (psr2-sprite-render)
[136.420531] Starting subtest: psr2-sprite-render
[136.423376] Starting dynamic subtest: eDP-1
[138.100773] Dynamic subtest eDP-1: SUCCESS (1.686s)
[138.103064] Subtest psr2-sprite-render: SUCCESS (1.687s)
[138.961929] [046/156] (879s left) kms_cursor_crc (cursor-offscreen-512x512)
[139.239949] Starting subtest: cursor-offscreen-512x512
[139.243840] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[139.392886] [047/156] (878s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[139.459679] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[139.463992] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[139.640567] [048/156] (878s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[139.731620] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[139.735911] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[139.820031] [049/156] (878s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[139.925824] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-blt
[139.930219] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[140.025397] [050/156] (878s left) kms_chamelium_frames (vga-frame-dump)
[140.423223] Subtest vga-frame-dump: SKIP (0.000s)
[141.268672] [051/156] (877s left) syncobj_timeline (invalid-query-bad-pad)
[141.323550] Starting subtest: invalid-query-bad-pad
[141.326008] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[141.443208] [052/156] (877s left) syncobj_timeline (wait-all-delayed-signal)
[141.501856] Starting subtest: wait-all-delayed-signal
[141.606109] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[141.696005] [053/156] (876s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite)
[141.795848] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite
[141.800414] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[141.892199] [054/156] (876s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[141.996586] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite
[142.000849] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[142.086373] [055/156] (876s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[142.138524] Starting subtest: multi-wait-all-for-submit-signaled
[142.140878] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[142.259470] [056/156] (876s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[142.362722] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[142.366924] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[142.463256] [057/156] (876s left) kms_rotation_crc (primary-rotation-270)
[142.560654] Starting subtest: primary-rotation-270
[142.565185] Subtest primary-rotation-270: SKIP (0.001s)
[142.632921] [058/156] (876s left) gem_userptr_blits (unsync-unmap)
[142.689306] Subtest unsync-unmap: SKIP (0.000s)
[142.822832] [059/156] (876s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[142.913907] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[142.917671] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[143.039735] [060/156] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[143.145564] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[150.505318] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.373s)
[150.652856] [061/156] (868s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[150.749913] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[150.753962] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[150.822830] [062/156] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[150.921691] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[150.926167] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[151.013228] [063/156] (868s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[151.113143] Starting subtest: random-ccs-data-y-tiled-ccs
[151.115396] Starting dynamic subtest: pipe-A-eDP-1
[151.140397] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.151173] Starting dynamic subtest: pipe-B-eDP-1
[151.175184] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.185565] Starting dynamic subtest: pipe-C-eDP-1
[151.209331] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.218426] Starting dynamic subtest: pipe-D-eDP-1
[151.242767] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.246931] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[153.385027] [064/156] (865s left) api_intel_bb (destroy-bb)
[153.446509] Starting subtest: destroy-bb
[153.453142] Subtest destroy-bb: SUCCESS (0.009s)
[153.587294] [065/156] (865s left) gem_set_tiling_vs_pwrite
[153.703247] [066/156] (865s left) i915_hangman (gt-error-state-capture)
[153.775156] Starting subtest: gt-error-state-capture
[153.777564] Starting dynamic subtest: rcs0
[164.876517] Dynamic subtest rcs0: SUCCESS (11.098s)
[164.889747] Starting dynamic subtest: bcs0
[176.907634] Dynamic subtest bcs0: SUCCESS (12.027s)
[176.919298] Starting dynamic subtest: vcs0
[187.851365] Dynamic subtest vcs0: SUCCESS (10.943s)
[187.864057] Starting dynamic subtest: vcs1
[198.860198] Dynamic subtest vcs1: SUCCESS (11.010s)
[198.872350] Starting dynamic subtest: vecs0
[209.867633] Dynamic subtest vecs0: SUCCESS (11.009s)
[209.882070] Starting dynamic subtest: ccs0
[221.899491] Dynamic subtest ccs0: SUCCESS (12.034s)
[221.902374] Subtest gt-error-state-capture: SUCCESS (68.131s)
[221.984002] [067/156] (797s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[222.079734] Starting subtest: primary-yf-tiled-reflect-x-270
[222.084071] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.000s)
[222.163799] [068/156] (797s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[222.214162] Starting subtest: multi-wait-available-unsubmitted-signaled
[222.216956] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[222.331204] [069/156] (796s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[222.427302] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[222.429692] Starting dynamic subtest: pipe-A
[223.575656] Dynamic subtest pipe-A: SUCCESS (1.151s)
[223.584604] Starting dynamic subtest: pipe-B
[225.826941] Dynamic subtest pipe-B: SUCCESS (2.250s)
[225.838742] Starting dynamic subtest: pipe-C
[227.073189] Dynamic subtest pipe-C: SUCCESS (1.245s)
[227.083679] Starting dynamic subtest: pipe-D
[228.300251] Dynamic subtest pipe-D: SUCCESS (1.226s)
[228.302706] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.874s)
[229.489129] [070/156] (789s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[229.588885] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[229.593374] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[229.682441] [071/156] (789s left) kms_rotation_crc (bad-tiling)
[229.773867] Starting subtest: bad-tiling
[229.778231] Subtest bad-tiling: SKIP (0.001s)
[229.856887] [072/156] (789s left) kms_addfb_basic (basic-y-tiled-legacy)
[229.916696] Starting subtest: basic-y-tiled-legacy
[229.921163] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[230.062753] [073/156] (789s left) perf (unprivileged-single-ctx-counters)
[230.184197] Starting subtest: unprivileged-single-ctx-counters
[230.188383] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[230.225880] [074/156] (789s left) kms_addfb_basic (too-high)
[230.313801] Starting subtest: too-high
[230.316008] Subtest too-high: SUCCESS (0.000s)
[230.412279] [075/156] (789s left) gem_close_race (basic-process)
[230.473304] Starting subtest: basic-process
[230.527107] Subtest basic-process: SUCCESS (0.055s)
[230.714284] [076/156] (788s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[230.823226] Starting subtest: pr-cursor-plane-move-continuous-sf
[230.827316] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[230.889407] [077/156] (788s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[230.949459] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[231.057325] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[231.133108] [078/156] (788s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[231.226336] Starting subtest: psr-rgb565-draw-mmap-gtt
[231.230414] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[231.326542] [079/156] (788s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[231.426995] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[231.431600] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[231.509003] [080/156] (788s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[231.611162] Starting subtest: hdr-rgb565-draw-render
[231.615432] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[231.709589] [081/156] (788s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte)
[231.808364] Starting subtest: fbcpsrhdr-2p-rte
[231.812351] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s)
[231.902728] [082/156] (787s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-plflip-blt)
[231.998142] Starting subtest: fbchdr-2p-scndscrn-indfb-plflip-blt
[232.002383] Subtest fbchdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[232.110245] [083/156] (787s left) gem_exec_schedule (preempt-engines)
[232.181107] Starting subtest: preempt-engines
[232.182981] Starting dynamic subtest: rcs0
[234.481126] Dynamic subtest rcs0: SUCCESS (2.303s)
[234.490797] Starting dynamic subtest: bcs0
[236.814602] Dynamic subtest bcs0: SUCCESS (2.278s)
[236.828207] Starting dynamic subtest: vcs0
[239.095379] Dynamic subtest vcs0: SUCCESS (2.280s)
[239.104778] Starting dynamic subtest: vcs1
[241.379862] Dynamic subtest vcs1: SUCCESS (2.282s)
[241.389237] Starting dynamic subtest: vecs0
[243.644352] Dynamic subtest vecs0: SUCCESS (2.262s)
[243.659262] Starting dynamic subtest: ccs0
[245.985445] Dynamic subtest ccs0: SUCCESS (2.340s)
[245.987571] Subtest preempt-engines: SUCCESS (13.756s)
[246.245484] [084/156] (773s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[246.366798] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[246.371296] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[246.507641] [085/156] (773s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[246.590614] Starting subtest: primary-4-tiled-reflect-x-180
[253.590197] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.001s)
[254.766634] [086/156] (765s left) gem_exec_reloc (basic-scanout)
[254.833483] Subtest basic-scanout: SKIP (0.000s)
[254.906190] [087/156] (765s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-plflip-blt)
[255.006609] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-plflip-blt
[255.011011] Subtest fbcpsrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[255.103321] [088/156] (764s left) kms_rotation_crc (exhaust-fences)
[255.188314] Starting subtest: exhaust-fences
[255.192407] Subtest exhaust-fences: SKIP (0.000s)
[255.259452] [089/156] (764s left) kms_flip (wf_vblank-ts-check-interruptible)
[255.350342] Starting subtest: wf_vblank-ts-check-interruptible
[255.352717] Starting dynamic subtest: A-eDP1
[264.254515] Dynamic subtest A-eDP1: SUCCESS (8.871s)
[264.266337] Starting dynamic subtest: B-eDP1
[273.186178] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[273.198597] Starting dynamic subtest: C-eDP1
[282.111448] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[282.120893] Starting dynamic subtest: D-eDP1
[291.047815] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[291.050178] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.660s)
[292.230804] [090/156] (727s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[292.329365] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[292.331253] Starting dynamic subtest: pipe-A-eDP-1
[294.497162] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.168s)
[294.507812] Starting dynamic subtest: pipe-B-eDP-1
[296.710674] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.214s)
[296.720328] Starting dynamic subtest: pipe-C-eDP-1
[298.790336] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.079s)
[298.800849] Starting dynamic subtest: pipe-D-eDP-1
[300.845509] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.055s)
[300.847586] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.520s)
[302.053740] [091/156] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[302.173298] Starting subtest: fbcpsr-2p-rte
[302.177602] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[302.272915] [092/156] (717s left) gem_mmap_wc (write-prefaulted)
[302.328860] Subtest write-prefaulted: SKIP (0.000s)
[302.391719] [093/156] (717s left) gem_exec_flush (basic-wb-set-default)
[302.451787] Starting subtest: basic-wb-set-default
[307.936579] Subtest basic-wb-set-default: SUCCESS (5.452s)
[308.103678] [094/156] (712s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[308.197814] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[317.676318] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.484s)
[317.812469] [095/156] (702s left) prime_self_import (basic-with_one_bo)
[317.849648] Starting subtest: basic-with_one_bo
[317.864092] Subtest basic-with_one_bo: SUCCESS (0.017s)
[317.985290] [096/156] (702s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[318.088142] Starting subtest: yf-tiled-64bpp-rotate-270
[318.092680] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[318.181564] [097/156] (702s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[318.282658] Starting subtest: psrhdr-farfromfence-mmap-gtt
[318.287166] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[318.396040] [098/156] (702s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[318.490551] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[318.494549] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[318.591327] [099/156] (701s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[318.695202] Starting subtest: bad-pixel-format-yf-tiled-ccs
[318.697075] Starting dynamic subtest: pipe-A-eDP-1
[318.717056] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[318.728274] Starting dynamic subtest: pipe-B-eDP-1
[318.746788] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[318.755581] Starting dynamic subtest: pipe-C-eDP-1
[318.773451] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[318.782224] Starting dynamic subtest: pipe-D-eDP-1
[318.800628] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[318.803971] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[320.979092] [100/156] (699s left) perf_pmu (render-node-busy-idle)
[321.043059] Starting subtest: render-node-busy-idle
[321.045404] Starting dynamic subtest: rcs0
[321.725873] Dynamic subtest rcs0: SUCCESS (0.682s)
[321.742375] Starting dynamic subtest: bcs0
[322.395860] Dynamic subtest bcs0: SUCCESS (0.668s)
[322.410362] Starting dynamic subtest: vcs0
[323.948711] Dynamic subtest vcs0: SUCCESS (1.549s)
[323.961386] Starting dynamic subtest: vcs1
[325.931270] Dynamic subtest vcs1: SUCCESS (1.981s)
[325.944601] Starting dynamic subtest: vecs0
[327.918123] Dynamic subtest vecs0: SUCCESS (1.982s)
[327.931726] Starting dynamic subtest: ccs0
[328.585590] Dynamic subtest ccs0: SUCCESS (0.667s)
[328.588177] Subtest render-node-busy-idle: SUCCESS (7.545s)
[328.660888] [101/156] (691s left) gem_ctx_persistence (hostile)
[328.715542] Starting subtest: hostile
[338.859723] Subtest hostile: SUCCESS (10.142s)
[338.939401] [102/156] (681s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[339.055648] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[339.059878] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[339.145964] [103/156] (681s left) kms_cursor_edge_walk (64x64-top-edge)
[339.244884] Starting subtest: 64x64-top-edge
[339.247239] Starting dynamic subtest: pipe-A-eDP-1
[342.726008] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.482s)
[342.738656] Starting dynamic subtest: pipe-D-eDP-1
[345.849998] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[345.852413] Subtest 64x64-top-edge: SUCCESS (6.607s)
[346.676597] [104/156] (674s left) kms_psr (psr2-cursor-mmap-gtt)
[346.768340] Starting subtest: psr2-cursor-mmap-gtt
[346.770662] Starting dynamic subtest: eDP-1
[348.455389] Dynamic subtest eDP-1: SUCCESS (1.686s)
[348.457672] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.687s)
[349.334413] [105/156] (671s left) kms_vblank (query-forked)
[349.432380] Starting subtest: query-forked
[349.434376] Starting dynamic subtest: pipe-A-eDP-1
[351.264154] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.832s)
[351.278229] Starting dynamic subtest: pipe-D-eDP-1
[353.841304] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.573s)
[353.843779] Subtest query-forked: SUCCESS (4.409s)
[354.709296] [106/156] (666s left) kms_pm_dc (dc9-dpms)
[355.805837] Starting subtest: dc9-dpms
[357.251133] Subtest dc9-dpms: SUCCESS (1.443s)
[357.337858] [107/156] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[357.440765] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[361.907970] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.471s)
[363.113513] [108/156] (657s left) prime_vgem (coherency-gtt)
[363.212208] Starting subtest: coherency-gtt
[363.216699] Subtest coherency-gtt: SKIP (0.000s)
[363.318124] [109/156] (657s left) i915_drm_fdinfo (most-busy-check-all)
[363.360288] Starting subtest: most-busy-check-all
[363.362917] Starting dynamic subtest: rcs0
[363.368219] Dynamic subtest rcs0: SKIP (0.004s)
[363.380214] Starting dynamic subtest: bcs0
[363.384895] Dynamic subtest bcs0: SKIP (0.000s)
[363.395153] Starting dynamic subtest: vcs0
[363.399654] Dynamic subtest vcs0: SKIP (0.000s)
[363.408903] Starting dynamic subtest: vcs1
[363.413044] Dynamic subtest vcs1: SKIP (0.000s)
[363.422235] Starting dynamic subtest: vecs0
[363.426321] Dynamic subtest vecs0: SKIP (0.000s)
[363.435455] Starting dynamic subtest: ccs0
[363.439588] Dynamic subtest ccs0: SKIP (0.000s)
[363.443729] Subtest most-busy-check-all: SKIP (0.010s)
[363.481323] [110/156] (657s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[363.608591] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[363.613180] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[363.726043] [111/156] (657s left) i915_pm_rps (thresholds-idle)
[363.785897] Starting subtest: thresholds-idle
[363.790391] Subtest thresholds-idle: SKIP (0.001s)
[363.908620] [112/156] (657s left) kms_getfb (getfb2-handle-closed)
[364.002022] Starting subtest: getfb2-handle-closed
[364.004845] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[364.110308] [113/156] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[364.202229] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[370.973832] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.773s)
[371.097437] [114/156] (650s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[371.162633] Subtest tiled-to-untiled: SKIP (0.000s)
[371.221872] [115/156] (649s left) kms_busy (extended-pageflip-hang-oldfb)
[371.320231] Starting subtest: extended-pageflip-hang-oldfb
[371.322576] Starting dynamic subtest: pipe-A
[371.708651] Dynamic subtest pipe-A: SUCCESS (0.386s)
[371.720948] Starting dynamic subtest: pipe-D
[372.857536] Dynamic subtest pipe-D: SUCCESS (1.148s)
[372.859672] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.538s)
[373.709706] [116/156] (647s left) kms_color (ctm-0-50)
[373.796857] Starting subtest: ctm-0-50
[373.798691] Starting dynamic subtest: pipe-A-eDP-1
[377.325913] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.529s)
[377.339174] Starting dynamic subtest: pipe-B-eDP-1
[381.621401] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.292s)
[381.632582] Starting dynamic subtest: pipe-C-eDP-1
[385.695796] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.075s)
[385.706791] Starting dynamic subtest: pipe-D-eDP-1
[389.725792] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.027s)
[389.728285] Subtest ctm-0-50: SUCCESS (15.925s)
[390.537713] [117/156] (630s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[390.639957] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[390.644399] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[390.751882] [118/156] (630s left) kms_vblank (ts-continuation-modeset)
[390.849991] Starting subtest: ts-continuation-modeset
[390.852317] Starting dynamic subtest: pipe-A-eDP-1
[392.302274] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.452s)
[392.316866] Starting dynamic subtest: pipe-D-eDP-1
[394.495980] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.186s)
[394.498323] Subtest ts-continuation-modeset: SUCCESS (3.646s)
[395.308496] [119/156] (626s left) gem_exec_reloc (basic-write-read)
[395.369215] Subtest basic-write-read: SKIP (0.000s)
[395.436724] [120/156] (625s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[395.546047] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[395.550522] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[395.639784] [121/156] (625s left) kms_lease (page-flip-implicit-plane)
[395.732856] Starting subtest: page-flip-implicit-plane
[395.735229] Starting dynamic subtest: pipe-A-eDP-1
[396.213973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s)
[396.225242] Starting dynamic subtest: pipe-B-eDP-1
[397.349538] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.134s)
[397.359855] Starting dynamic subtest: pipe-C-eDP-1
[398.464757] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[398.476289] Starting dynamic subtest: pipe-D-eDP-1
[399.611492] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s)
[399.613809] Subtest page-flip-implicit-plane: SUCCESS (3.880s)
[400.448648] [122/156] (621s left) kms_psr (fbc-psr2-primary-page-flip)
[400.536374] Starting subtest: fbc-psr2-primary-page-flip
[400.538707] Starting dynamic subtest: eDP-1
[400.543158] Dynamic subtest eDP-1: SKIP (0.000s)
[400.547645] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[400.610162] [123/156] (620s left) kms_properties (crtc-properties-legacy)
[400.701967] Starting subtest: crtc-properties-legacy
[400.704427] Starting dynamic subtest: pipe-A-eDP-1
[401.144658] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[401.154913] Starting dynamic subtest: pipe-B-eDP-1
[402.308663] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.163s)
[402.319138] Starting dynamic subtest: pipe-C-eDP-1
[403.442236] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[403.453206] Starting dynamic subtest: pipe-D-eDP-1
[404.567297] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[404.569551] Subtest crtc-properties-legacy: SUCCESS (3.866s)
[405.373298] [124/156] (616s left) core_getversion (basic)
[405.410976] Starting subtest: basic
[405.415336] Subtest basic: SUCCESS (0.000s)
[405.469165] [125/156] (616s left) gem_media_fill (media-fill)
[405.515913] Subtest media-fill: SKIP (0.000s)
[405.622612] [126/156] (616s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[405.949996] Starting subtest: cursor-rapid-movement-max-size
[405.956190] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[406.073365] [127/156] (615s left) kms_pm_backlight (basic-brightness)
[406.173841] Starting subtest: basic-brightness
[406.222944] Starting dynamic subtest: eDP-1
[406.724355] Dynamic subtest eDP-1: SUCCESS (0.499s)
[406.726789] Subtest basic-brightness: SUCCESS (0.550s)
[407.620816] [128/156] (614s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[407.715497] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[411.289255] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.580s)
[412.517984] [129/156] (609s left) api_intel_allocator (reopen)
[412.570195] Starting subtest: reopen
[412.574825] Subtest reopen: SUCCESS (0.006s)
[412.703335] [130/156] (609s left) gem_lmem_swapping (heavy-verify-random)
[412.742924] Subtest heavy-verify-random: SKIP (0.000s)
[412.784509] [131/156] (609s left) gem_exec_whisper (basic-fds-priority)
[412.845961] Starting subtest: basic-fds-priority
[435.732932] Subtest basic-fds-priority: SUCCESS (22.878s)
[435.925811] [132/156] (585s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[436.041064] Starting subtest: x-tiled-64bpp-rotate-270
[436.061045] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[436.178302] [133/156] (585s left) kms_psr (fbc-psr-suspend)
[436.266891] Starting subtest: fbc-psr-suspend
[436.269175] Starting dynamic subtest: eDP-1
[436.273222] Dynamic subtest eDP-1: SKIP (0.000s)
[436.277590] Subtest fbc-psr-suspend: SKIP (0.001s)
[436.347207] [134/156] (585s left) sysfs_preempt_timeout (idempotent)
[436.396869] Starting subtest: idempotent
[436.399151] Starting dynamic subtest: vecs0
[436.401330] Dynamic subtest vecs0: SUCCESS (0.001s)
[436.411499] Starting dynamic subtest: ccs0
[436.413693] Dynamic subtest ccs0: SUCCESS (0.000s)
[436.423349] Starting dynamic subtest: vcs0
[436.425581] Dynamic subtest vcs0: SUCCESS (0.000s)
[436.435208] Starting dynamic subtest: bcs0
[436.437693] Dynamic subtest bcs0: SUCCESS (0.000s)
[436.447889] Starting dynamic subtest: rcs0
[436.450115] Dynamic subtest rcs0: SUCCESS (0.000s)
[436.460050] Starting dynamic subtest: vcs1
[436.462400] Dynamic subtest vcs1: SUCCESS (0.000s)
[436.464644] Subtest idempotent: SUCCESS (0.006s)
[436.503027] [135/156] (585s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[436.609266] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[437.622755] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.015s)
[437.760443] [136/156] (584s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[437.857481] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[437.859457] Starting dynamic subtest: pipe-A-eDP-1
[437.878414] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[437.890255] Starting dynamic subtest: pipe-B-eDP-1
[437.910004] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[437.919534] Starting dynamic subtest: pipe-C-eDP-1
[437.937933] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[437.947467] Starting dynamic subtest: pipe-D-eDP-1
[437.966157] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[437.969887] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[440.180146] [137/156] (581s left) gem_partial_pwrite_pread (reads-uncached)
[440.226126] Subtest reads-uncached: SKIP (0.000s)
[440.303306] [138/156] (581s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[440.384556] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[440.386708] Starting dynamic subtest: pipe-A-default-mode
[443.120132] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[443.122482] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.737s)
[443.955807] [139/156] (578s left) gem_partial_pwrite_pread (write-display)
[444.014837] Subtest write-display: SKIP (0.000s)
[444.084783] [140/156] (578s left) gem_exec_params (rel-constants-invalid)
[444.138860] Starting subtest: rel-constants-invalid
[444.141248] Subtest rel-constants-invalid: SUCCESS (0.000s)
[444.259451] [141/156] (577s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[444.361494] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[444.365602] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[444.458901] [142/156] (577s left) kms_prime (basic-crc-hybrid)
[444.540668] Subtest basic-crc-hybrid: SKIP (0.000s)
[444.647403] [143/156] (577s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[444.745576] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[445.592601] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.848s)
[445.784779] [144/156] (576s left) kms_lease (atomic-implicit-crtc)
[445.880950] Starting subtest: atomic-implicit-crtc
[445.884644] Starting dynamic subtest: pipe-A-eDP-1
[445.895835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[445.909963] Starting dynamic subtest: pipe-B-eDP-1
[445.920501] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[445.930964] Starting dynamic subtest: pipe-C-eDP-1
[445.941252] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[445.951604] Starting dynamic subtest: pipe-D-eDP-1
[445.962377] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[445.964244] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[446.015017] [145/156] (576s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[446.112143] Starting subtest: fbc-psr2-cursor-plane-update-sf
[446.114409] Starting dynamic subtest: pipe-A-eDP-1
[446.184859] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[446.198075] Starting dynamic subtest: pipe-B-eDP-1
[447.334448] Dynamic subtest pipe-B-eDP-1: SKIP (1.147s)
[447.339141] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.227s)
[448.521131] [146/156] (573s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[448.613879] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[448.616222] Starting dynamic subtest: pipe-A-eDP-1
[448.639232] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.652464] Starting dynamic subtest: pipe-B-eDP-1
[448.674227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[448.687334] Starting dynamic subtest: pipe-C-eDP-1
[448.709646] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[448.721181] Starting dynamic subtest: pipe-D-eDP-1
[448.743185] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[448.747305] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[450.890489] [147/156] (571s left) perf_pmu (busy-idle)
[450.935371] Starting subtest: busy-idle
[450.937735] Starting dynamic subtest: rcs0
[451.632048] Dynamic subtest rcs0: SUCCESS (0.696s)
[451.644904] Starting dynamic subtest: bcs0
[452.292171] Dynamic subtest bcs0: SUCCESS (0.658s)
[452.306039] Starting dynamic subtest: vcs0
[453.932658] Dynamic subtest vcs0: SUCCESS (1.637s)
[453.945913] Starting dynamic subtest: vcs1
[455.918789] Dynamic subtest vcs1: SUCCESS (1.984s)
[455.932308] Starting dynamic subtest: vecs0
[457.901741] Dynamic subtest vecs0: SUCCESS (1.980s)
[457.915287] Starting dynamic subtest: ccs0
[458.575402] Dynamic subtest ccs0: SUCCESS (0.672s)
[458.577802] Subtest busy-idle: SUCCESS (7.641s)
[458.695444] [148/156] (563s left) gen7_exec_parse (oacontrol-tracking)
[458.748792] Subtest oacontrol-tracking: SKIP (0.000s)
[458.825815] [149/156] (563s left) gen3_render_linear_blits
[458.952322] [150/156] (563s left) kms_chamelium_hpd (common-hpd-after-suspend)
[459.337243] Subtest common-hpd-after-suspend: SKIP (0.000s)
[460.202059] [151/156] (562s left) kms_draw_crc (draw-method-mmap-gtt)
[460.299187] Starting subtest: draw-method-mmap-gtt
[460.303275] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[460.402220] [152/156] (562s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[460.498210] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[464.987634] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.494s)
[466.136002] [153/156] (556s left) gem_exec_balancer (waits)
[466.205894] Starting subtest: waits
[472.783123] Subtest waits: SUCCESS (6.522s)
[473.042193] [154/156] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[473.145982] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[480.267420] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.126s)
[480.405472] [155/156] (542s left) gem_eio (in-flight-1us)
[480.603916] Starting subtest: in-flight-1us
[488.585508] Subtest in-flight-1us: SUCCESS (7.983s)
[488.780881] [156/156] (534s left) kms_cursor_legacy (forked-move)
[488.896558] Starting subtest: forked-move
[488.898743] Starting dynamic subtest: pipe-A
[494.411752] Dynamic subtest pipe-A: SUCCESS (5.459s)
[494.425974] Starting dynamic subtest: pipe-B
[499.880178] Dynamic subtest pipe-B: SUCCESS (5.469s)
[499.892452] Starting dynamic subtest: pipe-C
[505.353977] Dynamic subtest pipe-C: SUCCESS (5.474s)
[505.366059] Starting dynamic subtest: pipe-D
[510.830148] Dynamic subtest pipe-D: SUCCESS (5.473s)
[510.850157] Starting dynamic subtest: all-pipes
[516.343967] Dynamic subtest all-pipes: SUCCESS (5.512s)
[516.346492] Subtest forked-move: SUCCESS (27.398s)
[516.443501] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: gem_mmap_wc
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: sw_sync
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: fbdev
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: gem_exec_fence
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: kms_plane
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: sriov_basic
results: parsing output: 22/ for test: kms_plane
results: parsing output: 23/ for test: gem_ctx_persistence
results: parsing output: 24/ for test: gem_ctx_param
results: parsing output: 25/ for test: gem_caching
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: i915_pm_rpm
results: parsing output: 29/ for test: gem_watchdog
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: gem_ctx_engines
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_ctx_sseu
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_plane_alpha_blend
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_chamelium_frames
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_flip_scaled_crc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 65/ for test: i915_hangman
results: parsing output: 66/ for test: kms_rotation_crc
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_rotation_crc
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: gem_close_race
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_mmap_wc
results: parsing output: 92/ for test: gem_exec_flush
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: prime_self_import
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_cursor_edge_walk
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: kms_pm_dc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: i915_pm_rps
results: parsing output: 111/ for test: kms_getfb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_set_tiling_vs_blt
results: parsing output: 114/ for test: kms_busy
results: parsing output: 115/ for test: kms_color
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_vblank
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_lease
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_properties
results: parsing output: 123/ for test: core_getversion
results: parsing output: 124/ for test: gem_media_fill
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_pm_backlight
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: api_intel_allocator
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: gem_exec_whisper
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_psr
results: parsing output: 133/ for test: sysfs_preempt_timeout
results: parsing output: 134/ for test: kms_big_fb
results: parsing output: 135/ for test: kms_ccs
results: parsing output: 136/ for test: gem_partial_pwrite_pread
results: parsing output: 137/ for test: kms_flip_scaled_crc
results: parsing output: 138/ for test: gem_partial_pwrite_pread
results: parsing output: 139/ for test: gem_exec_params
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_prime
results: parsing output: 142/ for test: kms_big_fb
results: parsing output: 143/ for test: kms_lease
results: parsing output: 144/ for test: kms_psr2_sf
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: perf_pmu
results: parsing output: 147/ for test: gen7_exec_parse
results: parsing output: 148/ for test: gen3_render_linear_blits
results: parsing output: 149/ for test: kms_chamelium_hpd
results: parsing output: 150/ for test: kms_draw_crc
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_exec_balancer
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_eio
results: parsing output: 155/ for test: kms_cursor_legacy
Done.