[57.695507] Initializing watchdogs
[57.695556]   /dev/watchdog0
[57.709963] [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]
[57.714590] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.716779] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.719958] [001/133] (960s left) gem_ctx_persistence (process)
[57.811587] Starting subtest: process
[58.016979] Subtest process: SUCCESS (0.205s)
[58.094877] [002/133] (960s left) gem_pxp (reject-modify-context-protection-off-1)
[58.225862] Starting subtest: reject-modify-context-protection-off-1
[58.228354] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[58.350798] [003/133] (959s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[58.486416] Starting subtest: short-flip-after-cursor-atomic-transitions
[59.487626] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.002s)
[60.361316] [004/133] (957s left) i915_suspend (basic-s3-without-i915)
[60.405333] Starting subtest: basic-s3-without-i915
[63.667396] Subtest basic-s3-without-i915: SKIP (3.257s)
[65.214155] [005/133] (953s left) kms_psr (psr2-primary-blt)
[65.313215] Starting subtest: psr2-primary-blt
[65.315546] Starting dynamic subtest: eDP-1
[67.090297] Dynamic subtest eDP-1: SUCCESS (1.775s)
[67.092811] Subtest psr2-primary-blt: SUCCESS (1.776s)
[67.981353] [006/133] (950s left) kms_selftest (drm_format_helper)
[68.018068] Starting subtest: drm_format_helper
[68.029412] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[68.122129] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.091s)
[68.131296] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[68.198023] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.078s)
[68.206477] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[68.279379] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.081s)
[68.287838] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[68.374555] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.094s)
[68.383932] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[68.454490] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.081s)
[68.461279] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[68.542655] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.087s)
[68.549794] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[68.636940] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.094s)
[68.644609] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[68.735316] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.098s)
[68.742539] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[68.816544] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.083s)
[68.823944] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[68.910939] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.092s)
[68.918927] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[69.003345] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.092s)
[69.010081] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[69.113805] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.111s)
[69.124878] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[69.212270] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.097s)
[69.219787] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[69.330064] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.117s)
[69.336839] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[69.428716] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.100s)
[69.437767] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[69.531396] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.101s)
[69.540126] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[69.641417] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.111s)
[69.643583] Subtest drm_format_helper: SUCCESS (1.623s)
[69.791168] [007/133] (948s left) gem_exec_schedule (submit-early-slice)
[69.869804] Starting subtest: submit-early-slice
[69.872069] Starting dynamic subtest: rcs0
[69.908934] Dynamic subtest rcs0: SUCCESS (0.044s)
[69.918950] Starting dynamic subtest: bcs0
[69.941500] Dynamic subtest bcs0: SUCCESS (0.033s)
[69.948934] Starting dynamic subtest: vcs0
[69.974747] Dynamic subtest vcs0: SUCCESS (0.033s)
[69.985357] Starting dynamic subtest: vcs1
[70.011068] Dynamic subtest vcs1: SUCCESS (0.036s)
[70.018536] Starting dynamic subtest: vecs0
[70.049577] Dynamic subtest vecs0: SUCCESS (0.038s)
[70.058485] Starting dynamic subtest: ccs0
[70.090592] Dynamic subtest ccs0: SUCCESS (0.041s)
[70.093018] Subtest submit-early-slice: SUCCESS (0.227s)
[71.985209] [008/133] (946s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[72.092018] Starting subtest: y-tiled-16bpp-rotate-90
[72.096393] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[72.193517] [009/133] (946s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[72.292901] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[72.304629] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[72.376654] [010/133] (946s left) prime_mmap (test_invalid_sync_flags)
[72.442950] Starting subtest: test_invalid_sync_flags
[72.445459] Starting dynamic subtest: test_invalid_sync_flags-smem
[72.448062] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[72.450358] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[72.559999] [011/133] (946s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[72.651224] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[72.653192] Starting dynamic subtest: pipe-A-eDP-1
[73.398864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[73.407082] Starting dynamic subtest: pipe-B-eDP-1
[75.206040] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.807s)
[75.215088] Starting dynamic subtest: pipe-C-eDP-1
[77.031318] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.824s)
[77.041673] Starting dynamic subtest: pipe-D-eDP-1
[78.865858] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.834s)
[78.867981] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.208s)
[79.999883] [012/133] (938s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[80.097019] Starting subtest: yf-tiled-16bpp-rotate-0
[80.101349] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[80.196963] [013/133] (938s left) sw_sync (sync_multi_producer_single_consumer)
[80.236464] Starting subtest: sync_multi_producer_single_consumer
[81.310343] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[81.366629] [014/133] (937s left) kms_properties (invalid-properties-legacy)
[81.460163] Starting subtest: invalid-properties-legacy
[81.567349] Subtest invalid-properties-legacy: SUCCESS (0.108s)
[81.642315] [015/133] (937s left) i915_pm_rps (reset)
[81.711983] Starting subtest: reset
[90.142640] Subtest reset: SUCCESS (8.427s)
[90.273840] [016/133] (928s left) gem_workarounds (reset-fd)
[90.351220] Starting subtest: reset-fd
[90.549155] Subtest reset-fd: SUCCESS (0.198s)
[90.684907] [017/133] (928s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[90.777137] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[90.779401] Starting dynamic subtest: A-eDP1
[94.316804] Dynamic subtest A-eDP1: SUCCESS (3.537s)
[94.330647] Starting dynamic subtest: B-eDP1
[97.512063] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[97.523815] Starting dynamic subtest: C-eDP1
[100.605105] Dynamic subtest C-eDP1: SUCCESS (3.093s)
[100.613313] Starting dynamic subtest: D-eDP1
[103.723376] Dynamic subtest D-eDP1: SUCCESS (3.118s)
[103.725271] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.949s)
[104.516266] [018/133] (914s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[104.616891] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[104.621057] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[104.716199] [019/133] (914s left) kms_flip (blocking-absolute-wf_vblank)
[104.811874] Starting subtest: blocking-absolute-wf_vblank
[104.814204] Starting dynamic subtest: A-eDP1
[113.608386] Dynamic subtest A-eDP1: SUCCESS (8.763s)
[113.619243] Starting dynamic subtest: B-eDP1
[122.331248] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[122.341687] Starting dynamic subtest: C-eDP1
[131.055815] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[131.065911] Starting dynamic subtest: D-eDP1
[139.737478] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[139.742122] Subtest blocking-absolute-wf_vblank: SUCCESS (34.933s)
[141.012132] [020/133] (877s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[141.125341] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[141.127613] Starting dynamic subtest: pipe-A-eDP-1
[141.147997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[141.156752] Starting dynamic subtest: pipe-B-eDP-1
[141.175860] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[141.183256] Starting dynamic subtest: pipe-C-eDP-1
[141.202677] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[141.210397] Starting dynamic subtest: pipe-D-eDP-1
[141.230351] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[141.232277] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[143.428176] [021/133] (875s left) kms_atomic_transition (modeset-transition-nonblocking)
[143.514241] Starting subtest: modeset-transition-nonblocking
[143.516563] Starting dynamic subtest: 1x-outputs
[154.603330] Dynamic subtest 1x-outputs: SUCCESS (11.091s)
[154.605978] Subtest modeset-transition-nonblocking: SUCCESS (11.092s)
[155.458765] [022/133] (863s left) gem_wait (invalid-buf)
[155.530751] Starting subtest: invalid-buf
[155.532786] Subtest invalid-buf: SUCCESS (0.000s)
[155.730277] [023/133] (863s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[155.819832] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[155.822120] Starting dynamic subtest: pipe-A-eDP-1
[155.844317] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[155.852516] Starting dynamic subtest: pipe-B-eDP-1
[155.873402] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[155.880968] Starting dynamic subtest: pipe-C-eDP-1
[155.902513] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[155.910120] Starting dynamic subtest: pipe-D-eDP-1
[155.931751] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[155.936151] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[158.358868] [024/133] (860s left) drm_read (short-buffer-nonblock)
[158.506044] Starting subtest: short-buffer-nonblock
[158.508598] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[158.631330] [025/133] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[158.725164] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[158.729303] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[158.835731] [026/133] (860s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[158.925739] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[158.928073] Starting dynamic subtest: pipe-A
[160.051344] Dynamic subtest pipe-A: SUCCESS (1.128s)
[160.060169] Starting dynamic subtest: pipe-B
[162.254366] Dynamic subtest pipe-B: SUCCESS (2.201s)
[162.273179] Starting dynamic subtest: pipe-C
[163.456682] Dynamic subtest pipe-C: SUCCESS (1.201s)
[163.466810] Starting dynamic subtest: pipe-D
[164.683448] Dynamic subtest pipe-D: SUCCESS (1.226s)
[164.685711] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.761s)
[165.878227] [027/133] (853s left) gem_exec_reloc (basic-gtt-read-active)
[165.933484] Subtest basic-gtt-read-active: SKIP (0.000s)
[165.997426] [028/133] (853s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[166.093296] Starting subtest: yf-tiled-64bpp-rotate-90
[166.097604] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[166.186801] [029/133] (853s left) kms_flip (modeset-vs-vblank-race-interruptible)
[166.279657] Starting subtest: modeset-vs-vblank-race-interruptible
[166.282064] Starting dynamic subtest: A-eDP1
[170.996578] Dynamic subtest A-eDP1: SUCCESS (4.716s)
[171.009034] Starting dynamic subtest: B-eDP1
[175.635397] Dynamic subtest B-eDP1: SUCCESS (4.637s)
[175.645563] Starting dynamic subtest: C-eDP1
[180.241446] Dynamic subtest C-eDP1: SUCCESS (4.604s)
[180.254161] Starting dynamic subtest: D-eDP1
[184.790206] Dynamic subtest D-eDP1: SUCCESS (4.547s)
[184.792589] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.514s)
[185.975567] [030/133] (833s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[186.087902] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[195.588382] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.503s)
[195.725626] [031/133] (823s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[195.820634] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[195.824769] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[195.920528] [032/133] (823s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[196.010099] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[196.012349] Starting dynamic subtest: pipe-A-eDP-1
[196.068601] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[196.077651] Starting dynamic subtest: pipe-B-eDP-1
[196.133643] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[196.143863] Starting dynamic subtest: pipe-C-eDP-1
[196.199220] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[196.208758] Starting dynamic subtest: pipe-D-eDP-1
[196.265065] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[196.269121] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[198.264121] [033/133] (821s left) sriov_basic (enable-vfs-autoprobe-on)
[198.334748] Starting subtest: enable-vfs-autoprobe-on
[198.337362] Starting dynamic subtest: numvfs-1
[198.416473] Dynamic subtest numvfs-1: FAIL (0.030s)
[198.427169] Starting dynamic subtest: numvfs-2
[198.497042] Dynamic subtest numvfs-2: FAIL (0.004s)
[198.505836] Starting dynamic subtest: numvfs-3
[198.579143] Dynamic subtest numvfs-3: FAIL (0.004s)
[198.588387] Starting dynamic subtest: numvfs-4
[198.660723] Dynamic subtest numvfs-4: FAIL (0.004s)
[198.670209] Starting dynamic subtest: numvfs-5
[198.742451] Dynamic subtest numvfs-5: FAIL (0.004s)
[198.751712] Starting dynamic subtest: numvfs-6
[198.823993] Dynamic subtest numvfs-6: FAIL (0.004s)
[198.833087] Starting dynamic subtest: numvfs-7
[198.906615] Dynamic subtest numvfs-7: FAIL (0.004s)
[198.916719] Starting dynamic subtest: numvfs-random
[198.986747] Dynamic subtest numvfs-random: FAIL (0.004s)
[198.996053] Starting dynamic subtest: numvfs-all
[199.070709] Dynamic subtest numvfs-all: FAIL (0.503s)
[199.073100] Subtest enable-vfs-autoprobe-on: FAIL (0.566s)
[199.110355] [034/133] (820s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[199.213825] Starting subtest: 4-tiled-8bpp-rotate-180
[200.463116] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.248s)
[200.592419] [035/133] (819s left) kms_psr (pr-primary-render)
[200.689476] Starting subtest: pr-primary-render
[200.693336] Subtest pr-primary-render: SKIP (0.000s)
[200.760449] [036/133] (818s left) gem_ctx_param (invalid-set-ringsize)
[200.818459] Starting subtest: invalid-set-ringsize
[200.820524] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[200.888506] [037/133] (818s left) gem_media_fill (media-fill)
[200.953279] Subtest media-fill: SKIP (0.000s)
[201.087340] [038/133] (818s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[201.177985] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[201.179982] Starting dynamic subtest: pipe-A
[201.240864] Dynamic subtest pipe-A: SUCCESS (0.065s)
[201.250466] Starting dynamic subtest: pipe-B
[202.378170] Dynamic subtest pipe-B: SUCCESS (1.136s)
[202.388442] Starting dynamic subtest: pipe-C
[203.494081] Dynamic subtest pipe-C: SUCCESS (1.114s)
[203.502318] Starting dynamic subtest: pipe-D
[204.630560] Dynamic subtest pipe-D: SUCCESS (1.136s)
[204.632919] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.455s)
[205.801676] [039/133] (813s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[205.860749] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[205.961732] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[206.041044] [040/133] (813s left) prime_udl
[206.124703] [041/133] (813s left) gem_exec_balancer (bonded-sync)
[206.185987] Starting subtest: bonded-sync
[206.190171] Subtest bonded-sync: SKIP (0.000s)
[206.489655] [042/133] (813s left) perf_pmu (gt-awake)
[206.527812] Starting subtest: gt-awake
[214.936775] Subtest gt-awake: SUCCESS (8.409s)
[215.059187] [043/133] (804s left) gem_userptr_blits (sync-overlap)
[215.130910] Starting subtest: sync-overlap
[215.133184] Subtest sync-overlap: SUCCESS (0.000s)
[215.239835] [044/133] (804s left) kms_content_protection (content-type-change)
[215.394772] Starting subtest: content-type-change
[215.399272] Subtest content-type-change: SKIP (0.000s)
[215.520425] [045/133] (804s left) api_intel_allocator (default-alignment)
[215.577470] Starting subtest: default-alignment
[215.579680] Subtest default-alignment: SUCCESS (0.003s)
[215.693157] [046/133] (804s left) kms_cursor_crc (cursor-offscreen-64x21)
[215.877789] Starting subtest: cursor-offscreen-64x21
[215.930838] Subtest cursor-offscreen-64x21: SKIP (0.047s)
[216.176880] [047/133] (803s left) kms_cursor_crc (cursor-random-256x85)
[216.436271] Starting subtest: cursor-random-256x85
[216.484602] Subtest cursor-random-256x85: SKIP (0.044s)
[216.649066] [048/133] (803s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[216.701535] Starting subtest: multi-wait-for-submit-submitted-signaled
[216.703565] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[216.806175] [049/133] (803s left) kms_psr (fbc-pr-sprite-blt)
[216.899270] Starting subtest: fbc-pr-sprite-blt
[216.902814] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[216.969655] [050/133] (803s left) kms_rotation_crc (primary-rotation-270)
[217.060279] Starting subtest: primary-rotation-270
[217.063795] Subtest primary-rotation-270: SKIP (0.001s)
[217.130379] [051/133] (803s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[217.194295] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[217.299031] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[217.373616] [052/133] (802s left) gem_eio (kms)
[217.623772] Starting subtest: kms
[235.222996] Subtest kms: SUCCESS (17.599s)
[236.421948] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[236.425714] [053/133] (783s left) gem_exec_reloc (basic-concurrent0)
[236.482271] Subtest basic-concurrent0: SKIP (0.000s)
[236.551595] [054/133] (783s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[236.647270] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[236.651332] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[236.720959] [055/133] (783s left) prime_self_import (basic-llseek-bad)
[236.759684] Starting subtest: basic-llseek-bad
[236.772939] Subtest basic-llseek-bad: SUCCESS (0.012s)
[236.868674] [056/133] (783s left) gen9_exec_parse (batch-invalid-length)
[236.924496] Subtest batch-invalid-length: SKIP (0.000s)
[237.014551] [057/133] (783s left) kms_psr (fbc-pr-cursor-plane-onoff)
[237.101409] Starting subtest: fbc-pr-cursor-plane-onoff
[237.105623] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[237.175830] [058/133] (783s left) kms_scaling_modes (scaling-mode-full)
[237.270018] Starting subtest: scaling-mode-full
[237.272230] Starting dynamic subtest: pipe-A-eDP-1
[237.363882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[237.373331] Starting dynamic subtest: pipe-B-eDP-1
[238.536066] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.170s)
[238.548746] Starting dynamic subtest: pipe-C-eDP-1
[239.667600] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[239.677132] Starting dynamic subtest: pipe-D-eDP-1
[240.803441] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[240.805727] Subtest scaling-mode-full: SUCCESS (3.537s)
[241.971217] [059/133] (778s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[242.375225] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[243.207650] [060/133] (777s left) gem_mmap_offset (mmap-unmap)
[243.272763] Starting subtest: mmap-unmap
[243.274690] Starting dynamic subtest: smem0
[266.347844] Dynamic subtest smem0: SUCCESS (23.025s)
[266.350419] Subtest mmap-unmap: SUCCESS (23.026s)
[266.440795] [061/133] (754s left) syncobj_wait (wait-any-interrupted)
[266.503632] Starting subtest: wait-any-interrupted
[266.604516] Subtest wait-any-interrupted: SUCCESS (0.102s)
[266.681418] [062/133] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[266.783697] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[273.614471] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.834s)
[273.764385] [063/133] (746s left) gem_softpin (softpin)
[273.825952] Starting subtest: softpin
[306.157763] Subtest softpin: SUCCESS (32.330s)
[306.290699] [064/133] (714s left) kms_pm_rpm (modeset-lpsp-stress)
[308.122937] Starting subtest: modeset-lpsp-stress
[324.642330] Subtest modeset-lpsp-stress: SUCCESS (16.521s)
[324.730938] [065/133] (696s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[324.797851] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[324.802126] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[324.982687] [066/133] (695s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[325.036970] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[325.039205] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[325.129533] [067/133] (695s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[325.227582] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[332.202709] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.978s)
[332.315164] [068/133] (688s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[332.424208] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[332.428114] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[332.522347] [069/133] (688s left) gem_basic (create-fd-close)
[332.590479] Starting subtest: create-fd-close
[332.594795] Subtest create-fd-close: SUCCESS (0.000s)
[332.692615] [070/133] (688s left) fbdev (nullptr)
[332.741555] Starting subtest: nullptr
[332.743895] Subtest nullptr: SUCCESS (0.000s)
[332.800578] [071/133] (688s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[332.904987] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[341.523093] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.621s)
[341.653147] [072/133] (679s left) gem_tiled_blits (basic)
[341.728660] Subtest basic: SKIP (0.000s)
[341.794810] [073/133] (679s left) tools_test (sysfs_l3_parity)
[341.843317] Starting subtest: sysfs_l3_parity
[341.928950] Subtest sysfs_l3_parity: SKIP (0.094s)
[341.984172] [074/133] (679s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[342.083082] Starting subtest: addfb25-y-tiled-small-legacy
[342.087104] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[342.166881] [075/133] (679s left) gem_create (create-valid-nonaligned)
[342.232324] Starting subtest: create-valid-nonaligned
[342.234250] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[342.420938] [076/133] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[342.522215] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[342.526466] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[342.615126] [077/133] (678s left) sw_sync (sync_merge)
[342.658012] Starting subtest: sync_merge
[342.659986] Subtest sync_merge: SUCCESS (0.000s)
[342.717168] [078/133] (678s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[342.803902] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[349.635220] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.833s)
[349.773477] [079/133] (671s left) gem_exec_flush (basic-uc-ro-default)
[349.842033] Starting subtest: basic-uc-ro-default
[355.325119] Subtest basic-uc-ro-default: SUCCESS (5.454s)
[355.485622] [080/133] (665s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[355.575665] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[355.579809] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[355.685421] [081/133] (665s left) kms_pipe_crc_basic (nonblocking-crc)
[355.787855] Starting subtest: nonblocking-crc
[355.790175] Starting dynamic subtest: pipe-A-eDP-1
[356.535846] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.750s)
[356.545644] Starting dynamic subtest: pipe-B-eDP-1
[357.926207] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s)
[357.935354] Starting dynamic subtest: pipe-C-eDP-1
[359.305394] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[359.314600] Starting dynamic subtest: pipe-D-eDP-1
[360.649309] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[360.651575] Subtest nonblocking-crc: SUCCESS (4.863s)
[361.445832] [082/133] (660s left) gem_wait (busy)
[361.508410] Starting subtest: busy
[361.510846] Starting dynamic subtest: all-engines
[362.903119] Dynamic subtest all-engines: SUCCESS (1.394s)
[362.914924] Starting dynamic subtest: rcs0
[363.444062] Dynamic subtest rcs0: SUCCESS (0.540s)
[363.454105] Starting dynamic subtest: bcs0
[363.985726] Dynamic subtest bcs0: SUCCESS (0.540s)
[363.997173] Starting dynamic subtest: vcs0
[365.914068] Dynamic subtest vcs0: SUCCESS (1.927s)
[365.925227] Starting dynamic subtest: vcs1
[367.894605] Dynamic subtest vcs1: SUCCESS (1.978s)
[367.906579] Starting dynamic subtest: vecs0
[369.942977] Dynamic subtest vecs0: SUCCESS (2.046s)
[369.955057] Starting dynamic subtest: ccs0
[370.485475] Dynamic subtest ccs0: SUCCESS (0.541s)
[370.488011] Subtest busy: SUCCESS (8.979s)
[370.684351] [083/133] (650s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[370.791709] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[377.660890] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.871s)
[377.806463] [084/133] (643s left) gem_mmap_gtt (medium-copy)
[377.863896] Subtest medium-copy: SKIP (0.000s)
[377.929993] [085/133] (643s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[378.028095] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[382.257447] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.233s)
[383.376781] [086/133] (638s left) kms_vblank (wait-idle)
[383.473310] Starting subtest: wait-idle
[383.475607] Starting dynamic subtest: pipe-A-eDP-1
[385.240344] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.768s)
[385.254979] Starting dynamic subtest: pipe-D-eDP-1
[387.716873] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.474s)
[387.719138] Subtest wait-idle: SUCCESS (4.246s)
[388.544445] [087/133] (633s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[388.656221] Starting subtest: short-busy-flip-before-cursor-toggle
[388.660579] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[388.814338] [088/133] (632s left) i915_drm_fdinfo (memory-info-idle)
[388.857322] Starting subtest: memory-info-idle
[388.859627] Starting dynamic subtest: smem0
[388.900564] Dynamic subtest smem0: SUCCESS (0.047s)
[388.903054] Subtest memory-info-idle: SUCCESS (0.047s)
[388.974500] [089/133] (632s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[389.075411] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[389.079880] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[389.173681] [090/133] (632s left) kms_plane_multiple (2x-tiling-yf)
[389.261868] Starting subtest: 2x-tiling-yf
[389.266314] Subtest 2x-tiling-yf: SKIP (0.000s)
[389.335592] [091/133] (632s left) gem_reg_read (timestamp-moving)
[389.382489] Starting subtest: timestamp-moving
[390.382731] Subtest timestamp-moving: SUCCESS (1.001s)
[390.471103] [092/133] (631s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[390.590200] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[390.594492] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[390.735152] [093/133] (631s left) sysfs_heartbeat_interval (invalid)
[390.791149] Starting subtest: invalid
[390.793474] Starting dynamic subtest: vecs0
[390.795810] Dynamic subtest vecs0: SUCCESS (0.000s)
[390.806628] Starting dynamic subtest: ccs0
[390.808501] Dynamic subtest ccs0: SUCCESS (0.000s)
[390.817211] Starting dynamic subtest: vcs0
[390.819050] Dynamic subtest vcs0: SUCCESS (0.000s)
[390.827802] Starting dynamic subtest: bcs0
[390.829654] Dynamic subtest bcs0: SUCCESS (0.000s)
[390.838782] Starting dynamic subtest: rcs0
[390.840816] Dynamic subtest rcs0: SUCCESS (0.000s)
[390.849434] Starting dynamic subtest: vcs1
[390.851265] Dynamic subtest vcs1: SUCCESS (0.000s)
[390.853085] Subtest invalid: SUCCESS (0.005s)
[390.895271] [094/133] (631s left) gem_exec_whisper (basic-queues-all)
[390.949363] Starting subtest: basic-queues-all
[402.868607] Subtest basic-queues-all: SUCCESS (11.918s)
[403.057452] [095/133] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[403.155262] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[403.159520] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[403.283371] [096/133] (618s left) api_intel_bb (delta-check)
[403.336017] Starting subtest: delta-check
[403.341063] Subtest delta-check: SUCCESS (0.007s)
[403.432490] [097/133] (618s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[403.537224] Starting subtest: pr-overlay-plane-move-continuous-sf
[403.541211] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[403.602748] [098/133] (618s left) perf_pmu (busy)
[403.646908] Starting subtest: busy
[403.649283] Starting dynamic subtest: rcs0
[404.236071] Dynamic subtest rcs0: SUCCESS (0.591s)
[404.248085] Starting dynamic subtest: bcs0
[404.805940] Dynamic subtest bcs0: SUCCESS (0.568s)
[404.821082] Starting dynamic subtest: vcs0
[405.910922] Dynamic subtest vcs0: SUCCESS (1.101s)
[405.923077] Starting dynamic subtest: vcs1
[407.894747] Dynamic subtest vcs1: SUCCESS (1.981s)
[407.906114] Starting dynamic subtest: vecs0
[409.878643] Dynamic subtest vecs0: SUCCESS (1.981s)
[409.890459] Starting dynamic subtest: ccs0
[410.443738] Dynamic subtest ccs0: SUCCESS (0.563s)
[410.446283] Subtest busy: SUCCESS (6.801s)
[410.561797] [099/133] (611s left) kms_color (invalid-gamma-lut-sizes)
[410.658670] Starting subtest: invalid-gamma-lut-sizes
[410.660915] Starting dynamic subtest: pipe-A
[410.944457] Dynamic subtest pipe-A: SUCCESS (0.285s)
[410.954072] Starting dynamic subtest: pipe-B
[410.956476] Dynamic subtest pipe-B: SUCCESS (0.000s)
[410.965493] Starting dynamic subtest: pipe-C
[410.967793] Dynamic subtest pipe-C: SUCCESS (0.000s)
[410.977069] Starting dynamic subtest: pipe-D
[410.979050] Dynamic subtest pipe-D: SUCCESS (0.000s)
[410.980942] Subtest invalid-gamma-lut-sizes: SUCCESS (0.289s)
[411.761440] [100/133] (610s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[411.852682] Starting subtest: fbc-indfb-scaledprimary
[414.877593] Subtest fbc-indfb-scaledprimary: SUCCESS (3.030s)
[416.058163] [101/133] (606s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[416.172144] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[417.273367] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.100s)
[417.420451] [102/133] (604s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[417.525855] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[417.529483] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[417.614929] [103/133] (604s left) gem_exec_basic (basic)
[417.668146] Starting subtest: basic
[417.670084] Starting dynamic subtest: rcs0-smem
[417.671864] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[417.681396] Starting dynamic subtest: bcs0-smem
[417.683334] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[417.691746] Starting dynamic subtest: vcs0-smem
[417.693609] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[417.702069] Starting dynamic subtest: vcs1-smem
[417.703847] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[417.712257] Starting dynamic subtest: vecs0-smem
[417.714038] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[417.722227] Starting dynamic subtest: ccs0-smem
[417.723999] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[417.725802] Subtest basic: SUCCESS (0.014s)
[418.945675] [104/133] (603s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[419.046200] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[423.469413] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.426s)
[424.682340] [105/133] (597s left) kms_psr (fbc-psr-sprite-blt)
[424.771136] Starting subtest: fbc-psr-sprite-blt
[424.773387] Starting dynamic subtest: eDP-1
[424.777527] Dynamic subtest eDP-1: SKIP (0.000s)
[424.781651] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[424.845085] [106/133] (597s left) syncobj_timeline (wait-all-complex)
[424.889280] Starting subtest: wait-all-complex
[425.103559] Subtest wait-all-complex: SUCCESS (0.214s)
[425.178958] [107/133] (597s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[425.272284] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[425.274570] Starting dynamic subtest: pipe-A-eDP-1
[426.208167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.930s)
[426.217954] Starting dynamic subtest: pipe-B-eDP-1
[427.889415] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.676s)
[427.904446] Starting dynamic subtest: pipe-C-eDP-1
[429.359504] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.471s)
[429.369912] Starting dynamic subtest: pipe-D-eDP-1
[430.913971] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.553s)
[430.916271] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.636s)
[432.061436] [108/133] (590s left) gem_mmap_wc (bad-offset)
[432.119629] Subtest bad-offset: SKIP (0.000s)
[432.203176] [109/133] (590s left) kms_hdr (static-swap)
[432.293081] Starting subtest: static-swap
[432.299477] Subtest static-swap: SKIP (0.000s)
[432.375466] [110/133] (590s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[432.473321] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[432.475554] Starting dynamic subtest: pipe-A-eDP-1
[433.809064] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.335s)
[434.088951] Starting dynamic subtest: pipe-B-eDP-1
[435.134408] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.053s)
[435.407891] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.936s)
[436.248346] [111/133] (586s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[436.337224] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[436.339508] Starting dynamic subtest: pipe-A-default-mode
[437.510790] Dynamic subtest pipe-A-default-mode: SKIP (1.171s)
[437.514594] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.173s)
[437.680790] [112/133] (585s left) kms_cursor_edge_walk (64x64-right-edge)
[437.783474] Starting subtest: 64x64-right-edge
[437.785753] Starting dynamic subtest: pipe-A-eDP-1
[441.250634] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[441.260322] Starting dynamic subtest: pipe-D-eDP-1
[444.383340] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[444.385521] Subtest 64x64-right-edge: SUCCESS (6.603s)
[445.201953] [113/133] (577s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[445.296084] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[445.300700] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[445.367894] [114/133] (577s left) gem_partial_pwrite_pread (writes-after-reads-display)
[445.439690] Subtest writes-after-reads-display: SKIP (0.000s)
[445.516280] [115/133] (577s left) kms_pm_rpm (dpms-non-lpsp)
[447.072476] Starting subtest: dpms-non-lpsp
[447.077146] Subtest dpms-non-lpsp: SKIP (0.001s)
[447.828167] [116/133] (575s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[447.884757] Starting subtest: multi-wait-all-for-submit-available-signaled
[447.886936] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[447.971757] [117/133] (575s left) gem_exec_fence (syncobj-import)
[448.416514] Starting subtest: syncobj-import
[448.421532] Subtest syncobj-import: SUCCESS (0.005s)
[449.957051] [118/133] (573s left) gem_exec_nop (basic-parallel)
[450.039021] Starting subtest: basic-parallel
[465.943700] Subtest basic-parallel: SUCCESS (15.915s)
[466.175043] [119/133] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[466.280769] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[466.285246] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[466.364709] [120/133] (556s left) perf (mi-rpc)
[466.477057] Starting subtest: mi-rpc
[466.481721] Subtest mi-rpc: SKIP (0.000s)
[466.520633] [121/133] (556s left) gem_exec_schedule (preempt-other-chain)
[466.592812] Starting subtest: preempt-other-chain
[466.594801] Starting dynamic subtest: rcs0
[466.672652] Dynamic subtest rcs0: SUCCESS (0.086s)
[466.684625] Starting dynamic subtest: bcs0
[466.754730] Dynamic subtest bcs0: SUCCESS (0.082s)
[466.768522] Starting dynamic subtest: vcs0
[466.838415] Dynamic subtest vcs0: SUCCESS (0.083s)
[466.849913] Starting dynamic subtest: vcs1
[466.925070] Dynamic subtest vcs1: SUCCESS (0.086s)
[466.940164] Starting dynamic subtest: vecs0
[467.008417] Dynamic subtest vecs0: SUCCESS (0.083s)
[467.020749] Starting dynamic subtest: ccs0
[467.087565] Dynamic subtest ccs0: SUCCESS (0.079s)
[467.089625] Subtest preempt-other-chain: SUCCESS (0.502s)
[468.018657] [122/133] (555s left) kms_draw_crc (draw-method-render)
[468.106237] Starting subtest: draw-method-render
[468.108148] Starting dynamic subtest: xrgb8888-untiled
[468.370845] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[468.381462] Starting dynamic subtest: rgb565-untiled
[468.604102] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[468.613852] Starting dynamic subtest: xrgb2101010-untiled
[468.837732] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[468.857644] Starting dynamic subtest: xbgr16161616f-untiled
[469.083219] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[469.108988] Starting dynamic subtest: xrgb8888-xtiled
[469.237520] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.154s)
[469.249708] Starting dynamic subtest: rgb565-xtiled
[469.370466] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[469.380081] Starting dynamic subtest: xrgb2101010-xtiled
[469.492678] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[469.502335] Starting dynamic subtest: xbgr16161616f-xtiled
[469.648260] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.155s)
[469.659744] Starting dynamic subtest: xrgb8888-4tiled
[469.781580] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[469.791358] Starting dynamic subtest: rgb565-4tiled
[469.903832] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[469.914081] Starting dynamic subtest: xrgb2101010-4tiled
[470.025809] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[470.035605] Starting dynamic subtest: xbgr16161616f-4tiled
[470.159453] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[470.161421] Subtest draw-method-render: SUCCESS (2.056s)
[470.256217] [123/133] (553s left) gem_create (hog-create)
[470.307456] Starting subtest: hog-create
[470.309473] Starting dynamic subtest: smem0
[503.893459] Dynamic subtest smem0: SUCCESS (33.584s)
[503.896018] Subtest hog-create: SUCCESS (33.586s)
[504.079305] [124/133] (519s left) kms_lease (atomic-implicit-crtc)
[504.180115] Starting subtest: atomic-implicit-crtc
[504.182523] Starting dynamic subtest: pipe-A-eDP-1
[504.193872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[504.207258] Starting dynamic subtest: pipe-B-eDP-1
[504.218653] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[504.228282] Starting dynamic subtest: pipe-C-eDP-1
[504.239237] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[504.248793] Starting dynamic subtest: pipe-D-eDP-1
[504.259714] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[504.262582] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[504.337315] [125/133] (519s left) kms_chamelium_color (ctm-red-to-blue)
[504.424402] Subtest ctm-red-to-blue: SKIP (0.000s)
[504.472433] [126/133] (518s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[504.560308] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[504.586787] Starting dynamic subtest: pipe-A-plane-0
[504.885820] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s)
[504.896286] Starting dynamic subtest: pipe-A-plane-3
[505.129905] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[506.199630] Starting dynamic subtest: pipe-B-plane-0
[506.492019] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[506.501700] Starting dynamic subtest: pipe-B-plane-3
[506.726304] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[507.051757] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.492s)
[507.887278] [127/133] (515s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[507.989910] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[507.994324] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[509.110368] [128/133] (514s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[509.213657] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[510.223833] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s)
[510.377054] [129/133] (513s left) i915_hangman (gt-engine-hang)
[510.443412] Starting subtest: gt-engine-hang
[510.445356] Starting dynamic subtest: rcs0
[511.862196] Dynamic subtest rcs0: SUCCESS (1.419s)
[511.875823] Starting dynamic subtest: bcs0
[513.908694] Dynamic subtest bcs0: SUCCESS (2.044s)
[513.921769] Starting dynamic subtest: vcs0
[515.893393] Dynamic subtest vcs0: SUCCESS (1.982s)
[515.906597] Starting dynamic subtest: vcs1
[517.876065] Dynamic subtest vcs1: SUCCESS (1.980s)
[517.888673] Starting dynamic subtest: vecs0
[519.862066] Dynamic subtest vecs0: SUCCESS (1.983s)
[519.874600] Starting dynamic subtest: ccs0
[521.844427] Dynamic subtest ccs0: SUCCESS (1.980s)
[521.847256] Subtest gt-engine-hang: SUCCESS (11.403s)
[521.965773] [130/133] (501s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[522.052420] Starting subtest: y-tiled-ccs-to-x-tiled
[522.057079] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[522.239897] [131/133] (501s left) gem_softpin (allocator-nopin)
[522.302085] Starting subtest: allocator-nopin
[522.407636] Subtest allocator-nopin: SUCCESS (0.104s)
[522.550642] [132/133] (501s left) dmabuf_sync_file (export-wait-after-attach)
[522.597960] Starting subtest: export-wait-after-attach
[522.599883] Subtest export-wait-after-attach: SUCCESS (0.001s)
[522.651474] [133/133] (501s left) gem_exec_whisper (basic-contexts-forked)
[522.709173] Starting subtest: basic-contexts-forked
[547.413807] Subtest basic-contexts-forked: SUCCESS (24.651s)
[547.542704] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: gem_pxp
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: i915_suspend
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_selftest
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: sw_sync
results: parsing output: 13/ for test: kms_properties
results: parsing output: 14/ for test: i915_pm_rps
results: parsing output: 15/ for test: gem_workarounds
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_atomic_transition
results: parsing output: 21/ for test: gem_wait
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: drm_read
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: sriov_basic
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_ctx_param
results: parsing output: 36/ for test: gem_media_fill
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: prime_udl
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: kms_content_protection
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_rotation_crc
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: prime_self_import
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_scaling_modes
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_softpin
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_basic
results: parsing output: 69/ for test: fbdev
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_tiled_blits
results: parsing output: 72/ for test: tools_test
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: gem_create
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_flush
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_pipe_crc_basic
results: parsing output: 81/ for test: gem_wait
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane_multiple
results: parsing output: 90/ for test: gem_reg_read
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: sysfs_heartbeat_interval
results: parsing output: 93/ for test: gem_exec_whisper
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_color
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_basic
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: gem_mmap_wc
results: parsing output: 108/ for test: kms_hdr
results: parsing output: 109/ for test: kms_atomic_transition
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: kms_cursor_edge_walk
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_exec_fence
results: parsing output: 117/ for test: gem_exec_nop
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_draw_crc
results: parsing output: 122/ for test: gem_create
results: parsing output: 123/ for test: kms_lease
results: parsing output: 124/ for test: kms_chamelium_color
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: i915_hangman
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: gem_softpin
results: parsing output: 131/ for test: dmabuf_sync_file
results: parsing output: 132/ for test: gem_exec_whisper
Done.