[61.897527] Initializing watchdogs
[61.897584]   /dev/watchdog0
[61.912428] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[61.916869] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.919087] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.922527] [001/133] (960s left) gem_ctx_persistence (process)
[62.014841] Starting subtest: process
[62.170819] Subtest process: SUCCESS (0.156s)
[62.297596] [002/133] (960s left) gem_pxp (reject-modify-context-protection-off-1)
[62.423732] Starting subtest: reject-modify-context-protection-off-1
[62.426221] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[62.541042] [003/133] (959s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[62.652934] Starting subtest: short-flip-after-cursor-atomic-transitions
[63.650718] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.999s)
[64.464807] [004/133] (958s left) i915_suspend (basic-s3-without-i915)
[64.502359] Starting subtest: basic-s3-without-i915
[68.384878] Subtest basic-s3-without-i915: SKIP (3.885s)
[69.955841] [005/133] (952s left) kms_psr (psr2-primary-blt)
[70.066154] Starting subtest: psr2-primary-blt
[70.068409] Starting dynamic subtest: eDP-1
[71.842240] Dynamic subtest eDP-1: SUCCESS (1.777s)
[71.844594] Subtest psr2-primary-blt: SUCCESS (1.777s)
[72.707882] [006/133] (949s left) kms_selftest (drm_format_helper)
[72.755493] Starting subtest: drm_format_helper
[72.765251] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[72.852226] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.087s)
[72.861171] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[72.955841] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.101s)
[72.964079] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[73.069178] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.115s)
[73.077935] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[73.149729] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.079s)
[73.157729] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[73.243252] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.093s)
[73.250164] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[73.335769] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.093s)
[73.344059] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[73.424505] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.087s)
[73.431769] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[73.510069] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.086s)
[73.518268] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[73.607281] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.097s)
[73.614393] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[73.703261] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.095s)
[73.710836] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[73.803215] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.099s)
[73.811679] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[73.897246] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.094s)
[73.904081] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[73.984250] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.088s)
[73.991333] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[74.072602] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.088s)
[74.079137] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[74.159069] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.086s)
[74.165623] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[74.255265] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.097s)
[74.261556] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[74.346928] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.091s)
[74.348764] Subtest drm_format_helper: SUCCESS (1.592s)
[74.491327] [007/133] (948s left) gem_exec_schedule (submit-early-slice)
[74.561048] Starting subtest: submit-early-slice
[74.562785] Starting dynamic subtest: rcs0
[74.604700] Dynamic subtest rcs0: SUCCESS (0.046s)
[74.613571] Starting dynamic subtest: bcs0
[74.643734] Dynamic subtest bcs0: SUCCESS (0.039s)
[74.650867] Starting dynamic subtest: vcs0
[74.679621] Dynamic subtest vcs0: SUCCESS (0.036s)
[74.692499] Starting dynamic subtest: vcs1
[74.716196] Dynamic subtest vcs1: SUCCESS (0.036s)
[74.725844] Starting dynamic subtest: vecs0
[74.750923] Dynamic subtest vecs0: SUCCESS (0.035s)
[74.758525] Starting dynamic subtest: ccs0
[74.785413] Dynamic subtest ccs0: SUCCESS (0.034s)
[74.787472] Subtest submit-early-slice: SUCCESS (0.227s)
[76.001891] [008/133] (946s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[76.106744] Starting subtest: y-tiled-16bpp-rotate-90
[76.111396] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[76.204935] [009/133] (946s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[76.301797] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[76.314063] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[76.386691] [010/133] (946s left) prime_mmap (test_invalid_sync_flags)
[76.448146] Starting subtest: test_invalid_sync_flags
[76.450670] Starting dynamic subtest: test_invalid_sync_flags-smem
[76.453027] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[76.455242] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[76.536930] [011/133] (946s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[76.635022] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[76.637353] Starting dynamic subtest: pipe-A-eDP-1
[77.380405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[77.389516] Starting dynamic subtest: pipe-B-eDP-1
[79.149836] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.768s)
[79.161155] Starting dynamic subtest: pipe-C-eDP-1
[80.980082] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.829s)
[80.987545] Starting dynamic subtest: pipe-D-eDP-1
[82.811444] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.830s)
[82.813803] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.170s)
[83.944529] [012/133] (938s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[84.042656] Starting subtest: yf-tiled-16bpp-rotate-0
[84.046717] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[84.173285] [013/133] (938s left) sw_sync (sync_multi_producer_single_consumer)
[84.215713] Starting subtest: sync_multi_producer_single_consumer
[85.289898] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[85.346659] [014/133] (937s left) kms_properties (invalid-properties-legacy)
[85.439801] Starting subtest: invalid-properties-legacy
[85.546066] Subtest invalid-properties-legacy: SUCCESS (0.107s)
[85.615919] [015/133] (937s left) i915_pm_rps (reset)
[85.676025] Starting subtest: reset
[94.143659] Subtest reset: SUCCESS (8.466s)
[94.254227] [016/133] (928s left) gem_workarounds (reset-fd)
[94.324401] Starting subtest: reset-fd
[94.513689] Subtest reset-fd: SUCCESS (0.189s)
[94.638164] [017/133] (928s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[94.742509] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[94.744783] Starting dynamic subtest: A-eDP1
[98.383951] Dynamic subtest A-eDP1: SUCCESS (3.638s)
[98.399358] Starting dynamic subtest: B-eDP1
[101.576967] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[101.591589] Starting dynamic subtest: C-eDP1
[104.688809] Dynamic subtest C-eDP1: SUCCESS (3.111s)
[104.697258] Starting dynamic subtest: D-eDP1
[107.802189] Dynamic subtest D-eDP1: SUCCESS (3.112s)
[107.804559] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.060s)
[108.607335] [018/133] (914s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[108.707423] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[108.711669] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[108.802954] [019/133] (914s left) kms_flip (blocking-absolute-wf_vblank)
[108.896592] Starting subtest: blocking-absolute-wf_vblank
[108.899023] Starting dynamic subtest: A-eDP1
[117.686452] Dynamic subtest A-eDP1: SUCCESS (8.755s)
[117.697638] Starting dynamic subtest: B-eDP1
[126.414741] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[126.424743] Starting dynamic subtest: C-eDP1
[135.156523] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[135.164263] Starting dynamic subtest: D-eDP1
[143.829213] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[143.834491] Subtest blocking-absolute-wf_vblank: SUCCESS (34.938s)
[145.045333] [020/133] (878s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[145.143041] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[145.145306] Starting dynamic subtest: pipe-A-eDP-1
[145.168811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[145.179299] Starting dynamic subtest: pipe-B-eDP-1
[145.198371] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[145.206678] Starting dynamic subtest: pipe-C-eDP-1
[145.225278] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[145.233173] Starting dynamic subtest: pipe-D-eDP-1
[145.252658] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[145.254950] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[147.398359] [021/133] (875s left) kms_atomic_transition (modeset-transition-nonblocking)
[147.499888] Starting subtest: modeset-transition-nonblocking
[147.501995] Starting dynamic subtest: 1x-outputs
[158.367180] Dynamic subtest 1x-outputs: SUCCESS (10.868s)
[158.369742] Subtest modeset-transition-nonblocking: SUCCESS (10.869s)
[159.226416] [022/133] (864s left) gem_wait (invalid-buf)
[159.276593] Starting subtest: invalid-buf
[159.278793] Subtest invalid-buf: SUCCESS (0.000s)
[159.476450] [023/133] (863s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[159.574206] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[159.576391] Starting dynamic subtest: pipe-A-eDP-1
[159.598416] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[159.608704] Starting dynamic subtest: pipe-B-eDP-1
[159.629509] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[159.637133] Starting dynamic subtest: pipe-C-eDP-1
[159.658565] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[159.666123] Starting dynamic subtest: pipe-D-eDP-1
[159.688200] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[159.692238] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[161.899976] [024/133] (861s left) drm_read (short-buffer-nonblock)
[162.047961] Starting subtest: short-buffer-nonblock
[162.050246] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[162.159542] [025/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[162.262664] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[162.267191] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[162.348954] [026/133] (861s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[162.441083] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[162.443332] Starting dynamic subtest: pipe-A
[163.578305] Dynamic subtest pipe-A: SUCCESS (1.140s)
[163.586647] Starting dynamic subtest: pipe-B
[165.800073] Dynamic subtest pipe-B: SUCCESS (2.221s)
[165.808493] Starting dynamic subtest: pipe-C
[167.001186] Dynamic subtest pipe-C: SUCCESS (1.200s)
[167.013990] Starting dynamic subtest: pipe-D
[168.233369] Dynamic subtest pipe-D: SUCCESS (1.230s)
[168.235740] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.796s)
[169.416067] [027/133] (854s left) gem_exec_reloc (basic-gtt-read-active)
[169.485637] Subtest basic-gtt-read-active: SKIP (0.000s)
[169.561753] [028/133] (853s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[169.662943] Starting subtest: yf-tiled-64bpp-rotate-90
[169.667040] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[169.757636] [029/133] (853s left) kms_flip (modeset-vs-vblank-race-interruptible)
[169.846427] Starting subtest: modeset-vs-vblank-race-interruptible
[169.848780] Starting dynamic subtest: A-eDP1
[174.538201] Dynamic subtest A-eDP1: SUCCESS (4.691s)
[174.548930] Starting dynamic subtest: B-eDP1
[179.178045] Dynamic subtest B-eDP1: SUCCESS (4.637s)
[179.189878] Starting dynamic subtest: C-eDP1
[183.772773] Dynamic subtest C-eDP1: SUCCESS (4.593s)
[183.780713] Starting dynamic subtest: D-eDP1
[188.321899] Dynamic subtest D-eDP1: SUCCESS (4.548s)
[188.327133] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.482s)
[189.477961] [030/133] (834s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[189.574509] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[198.971313] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.398s)
[199.095462] [031/133] (824s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[199.200454] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[199.204531] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[199.303962] [032/133] (824s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[199.404250] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[199.406517] Starting dynamic subtest: pipe-A-eDP-1
[199.465068] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[199.474406] Starting dynamic subtest: pipe-B-eDP-1
[199.533210] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[199.542694] Starting dynamic subtest: pipe-C-eDP-1
[199.599034] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[199.608219] Starting dynamic subtest: pipe-D-eDP-1
[199.665106] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[199.669169] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[201.649080] [033/133] (822s left) sriov_basic (enable-vfs-autoprobe-on)
[201.704867] Starting subtest: enable-vfs-autoprobe-on
[201.707206] Starting dynamic subtest: numvfs-1
[201.782633] Dynamic subtest numvfs-1: FAIL (0.013s)
[201.794561] Starting dynamic subtest: numvfs-2
[201.867329] Dynamic subtest numvfs-2: FAIL (0.004s)
[201.876783] Starting dynamic subtest: numvfs-3
[201.948854] Dynamic subtest numvfs-3: FAIL (0.004s)
[201.958188] Starting dynamic subtest: numvfs-4
[202.029875] Dynamic subtest numvfs-4: FAIL (0.004s)
[202.039732] Starting dynamic subtest: numvfs-5
[202.112428] Dynamic subtest numvfs-5: FAIL (0.004s)
[202.121530] Starting dynamic subtest: numvfs-6
[202.193692] Dynamic subtest numvfs-6: FAIL (0.003s)
[202.202876] Starting dynamic subtest: numvfs-7
[202.277730] Dynamic subtest numvfs-7: FAIL (0.004s)
[202.287449] Starting dynamic subtest: numvfs-random
[202.359195] Dynamic subtest numvfs-random: FAIL (0.003s)
[202.370635] Starting dynamic subtest: numvfs-all
[202.439659] Dynamic subtest numvfs-all: FAIL (0.508s)
[202.441802] Subtest enable-vfs-autoprobe-on: FAIL (0.553s)
[202.481575] [034/133] (821s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[202.588191] Starting subtest: 4-tiled-8bpp-rotate-180
[203.837165] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.248s)
[203.970399] [035/133] (819s left) kms_psr (pr-primary-render)
[204.068518] Starting subtest: pr-primary-render
[204.072223] Subtest pr-primary-render: SKIP (0.000s)
[204.141741] [036/133] (819s left) gem_ctx_param (invalid-set-ringsize)
[204.200604] Starting subtest: invalid-set-ringsize
[204.202876] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[204.273176] [037/133] (819s left) gem_media_fill (media-fill)
[204.329061] Subtest media-fill: SKIP (0.000s)
[204.421826] [038/133] (819s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[204.523438] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[204.525067] Starting dynamic subtest: pipe-A
[204.589448] Dynamic subtest pipe-A: SUCCESS (0.068s)
[204.597534] Starting dynamic subtest: pipe-B
[205.777175] Dynamic subtest pipe-B: SUCCESS (1.186s)
[205.789059] Starting dynamic subtest: pipe-C
[206.887674] Dynamic subtest pipe-C: SUCCESS (1.109s)
[206.896013] Starting dynamic subtest: pipe-D
[208.019385] Dynamic subtest pipe-D: SUCCESS (1.131s)
[208.021652] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.498s)
[209.189109] [039/133] (814s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[209.250571] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[209.352351] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[209.431360] [040/133] (814s left) prime_udl
[209.513576] [041/133] (814s left) gem_exec_balancer (bonded-sync)
[209.586314] Starting subtest: bonded-sync
[209.590727] Subtest bonded-sync: SKIP (0.000s)
[209.897212] [042/133] (814s left) perf_pmu (gt-awake)
[209.936325] Starting subtest: gt-awake
[218.902048] Subtest gt-awake: SUCCESS (8.965s)
[219.015069] [043/133] (805s left) gem_userptr_blits (sync-overlap)
[219.083964] Starting subtest: sync-overlap
[219.086324] Subtest sync-overlap: SUCCESS (0.000s)
[219.210490] [044/133] (804s left) kms_content_protection (content-type-change)
[219.352415] Starting subtest: content-type-change
[219.356607] Subtest content-type-change: SKIP (0.000s)
[219.462520] [045/133] (804s left) api_intel_allocator (default-alignment)
[219.518426] Starting subtest: default-alignment
[219.520765] Subtest default-alignment: SUCCESS (0.003s)
[219.625947] [046/133] (804s left) kms_cursor_crc (cursor-offscreen-64x21)
[219.829727] Starting subtest: cursor-offscreen-64x21
[219.881778] Subtest cursor-offscreen-64x21: SKIP (0.047s)
[220.125227] [047/133] (804s left) kms_cursor_crc (cursor-random-256x85)
[220.396362] Starting subtest: cursor-random-256x85
[220.444530] Subtest cursor-random-256x85: SKIP (0.043s)
[220.615874] [048/133] (803s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[220.670324] Starting subtest: multi-wait-for-submit-submitted-signaled
[220.672395] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[220.760725] [049/133] (803s left) kms_psr (fbc-pr-sprite-blt)
[220.860823] Starting subtest: fbc-pr-sprite-blt
[220.864547] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[220.930599] [050/133] (803s left) kms_rotation_crc (primary-rotation-270)
[221.025508] Starting subtest: primary-rotation-270
[221.029181] Subtest primary-rotation-270: SKIP (0.001s)
[221.098914] [051/133] (803s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[221.152122] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[221.257065] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[221.330365] [052/133] (803s left) gem_eio (kms)
[221.568934] Starting subtest: kms
[238.160262] Subtest kms: SUCCESS (16.590s)
[238.269394] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[238.272878] [053/133] (786s left) gem_exec_reloc (basic-concurrent0)
[238.324052] Subtest basic-concurrent0: SKIP (0.000s)
[238.397872] [054/133] (786s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[238.495913] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[238.500141] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[238.571479] [055/133] (785s left) prime_self_import (basic-llseek-bad)
[238.609321] Starting subtest: basic-llseek-bad
[238.627561] Subtest basic-llseek-bad: SUCCESS (0.020s)
[238.714662] [056/133] (785s left) gen9_exec_parse (batch-invalid-length)
[238.772367] Subtest batch-invalid-length: SKIP (0.000s)
[238.840898] [057/133] (785s left) kms_psr (fbc-pr-cursor-plane-onoff)
[238.936297] Starting subtest: fbc-pr-cursor-plane-onoff
[238.940143] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[239.008944] [058/133] (785s left) kms_scaling_modes (scaling-mode-full)
[239.094178] Starting subtest: scaling-mode-full
[239.096374] Starting dynamic subtest: pipe-A-eDP-1
[239.187470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[239.197154] Starting dynamic subtest: pipe-B-eDP-1
[240.333743] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.143s)
[240.344076] Starting dynamic subtest: pipe-C-eDP-1
[241.449803] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[241.459063] Starting dynamic subtest: pipe-D-eDP-1
[242.574936] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[242.577289] Subtest scaling-mode-full: SUCCESS (3.484s)
[243.751403] [059/133] (780s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[244.140642] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[244.954502] [060/133] (779s left) gem_mmap_offset (mmap-unmap)
[245.005176] Starting subtest: mmap-unmap
[245.007458] Starting dynamic subtest: smem0
[268.234428] Dynamic subtest smem0: SUCCESS (23.178s)
[268.236983] Subtest mmap-unmap: SUCCESS (23.180s)
[268.299345] [061/133] (756s left) syncobj_wait (wait-any-interrupted)
[268.363830] Starting subtest: wait-any-interrupted
[268.466852] Subtest wait-any-interrupted: SUCCESS (0.101s)
[268.544131] [062/133] (756s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[268.649641] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[275.516118] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.869s)
[275.651945] [063/133] (749s left) gem_softpin (softpin)
[275.723066] Starting subtest: softpin
[308.084671] Subtest softpin: SUCCESS (32.356s)
[308.187099] [064/133] (716s left) kms_pm_rpm (modeset-lpsp-stress)
[310.015601] Starting subtest: modeset-lpsp-stress
[326.577671] Subtest modeset-lpsp-stress: SUCCESS (16.563s)
[326.684483] [065/133] (698s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[326.754533] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[326.759092] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[326.938169] [066/133] (698s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[326.989601] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[326.991777] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[327.107449] [067/133] (697s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[327.211323] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[334.275086] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.066s)
[334.388226] [068/133] (690s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[334.502305] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[334.506639] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[334.598609] [069/133] (690s left) gem_basic (create-fd-close)
[334.658310] Starting subtest: create-fd-close
[334.662321] Subtest create-fd-close: SUCCESS (0.000s)
[334.778114] [070/133] (690s left) fbdev (nullptr)
[334.832856] Starting subtest: nullptr
[334.835353] Subtest nullptr: SUCCESS (0.000s)
[334.907218] [071/133] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[335.014510] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[343.710738] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.699s)
[343.839964] [072/133] (681s left) gem_tiled_blits (basic)
[343.912250] Subtest basic: SKIP (0.000s)
[343.987205] [073/133] (681s left) tools_test (sysfs_l3_parity)
[344.039292] Starting subtest: sysfs_l3_parity
[344.089788] Subtest sysfs_l3_parity: SKIP (0.066s)
[344.153889] [074/133] (681s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[344.237514] Starting subtest: addfb25-y-tiled-small-legacy
[344.241931] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[344.329388] [075/133] (681s left) gem_create (create-valid-nonaligned)
[344.378077] Starting subtest: create-valid-nonaligned
[344.379951] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[344.566048] [076/133] (680s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[344.658856] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[344.663251] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[344.777490] [077/133] (680s left) sw_sync (sync_merge)
[344.815988] Starting subtest: sync_merge
[344.818259] Subtest sync_merge: SUCCESS (0.000s)
[344.877356] [078/133] (680s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[344.980438] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[351.878826] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.900s)
[352.006177] [079/133] (673s left) gem_exec_flush (basic-uc-ro-default)
[352.064459] Starting subtest: basic-uc-ro-default
[357.548808] Subtest basic-uc-ro-default: SUCCESS (5.454s)
[357.705892] [080/133] (667s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[357.806408] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[357.810494] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[357.908531] [081/133] (667s left) kms_pipe_crc_basic (nonblocking-crc)
[357.989239] Starting subtest: nonblocking-crc
[357.991149] Starting dynamic subtest: pipe-A-eDP-1
[358.740086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.750s)
[358.749795] Starting dynamic subtest: pipe-B-eDP-1
[360.168291] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.427s)
[360.177802] Starting dynamic subtest: pipe-C-eDP-1
[361.523810] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s)
[361.536542] Starting dynamic subtest: pipe-D-eDP-1
[362.863064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[362.865444] Subtest nonblocking-crc: SUCCESS (4.877s)
[363.664362] [082/133] (662s left) gem_wait (busy)
[363.727930] Starting subtest: busy
[363.730255] Starting dynamic subtest: all-engines
[364.884983] Dynamic subtest all-engines: SUCCESS (1.155s)
[364.896972] Starting dynamic subtest: rcs0
[365.426067] Dynamic subtest rcs0: SUCCESS (0.539s)
[365.438087] Starting dynamic subtest: bcs0
[365.965354] Dynamic subtest bcs0: SUCCESS (0.538s)
[365.976606] Starting dynamic subtest: vcs0
[367.893463] Dynamic subtest vcs0: SUCCESS (1.926s)
[367.905815] Starting dynamic subtest: vcs1
[369.876494] Dynamic subtest vcs1: SUCCESS (1.980s)
[369.888415] Starting dynamic subtest: vecs0
[371.924522] Dynamic subtest vecs0: SUCCESS (2.045s)
[371.936731] Starting dynamic subtest: ccs0
[372.466718] Dynamic subtest ccs0: SUCCESS (0.541s)
[372.469518] Subtest busy: SUCCESS (8.739s)
[372.664365] [083/133] (653s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[372.763083] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[379.664873] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.905s)
[379.778578] [084/133] (645s left) gem_mmap_gtt (medium-copy)
[379.833884] Subtest medium-copy: SKIP (0.000s)
[379.898290] [085/133] (645s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[380.000276] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[384.148239] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.150s)
[385.295115] [086/133] (640s left) kms_vblank (wait-idle)
[385.386885] Starting subtest: wait-idle
[385.388991] Starting dynamic subtest: pipe-A-eDP-1
[387.137067] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[387.152102] Starting dynamic subtest: pipe-D-eDP-1
[389.605397] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.465s)
[389.607767] Subtest wait-idle: SUCCESS (4.223s)
[390.418498] [087/133] (635s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[390.538263] Starting subtest: short-busy-flip-before-cursor-toggle
[390.542673] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[390.685448] [088/133] (635s left) i915_drm_fdinfo (memory-info-idle)
[390.726564] Starting subtest: memory-info-idle
[390.728716] Starting dynamic subtest: smem0
[390.774668] Dynamic subtest smem0: SUCCESS (0.049s)
[390.777350] Subtest memory-info-idle: SUCCESS (0.050s)
[390.851625] [089/133] (635s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[390.950105] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[390.954055] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[391.047132] [090/133] (634s left) kms_plane_multiple (2x-tiling-yf)
[391.139067] Starting subtest: 2x-tiling-yf
[391.143021] Subtest 2x-tiling-yf: SKIP (0.000s)
[391.236431] [091/133] (634s left) gem_reg_read (timestamp-moving)
[391.287648] Starting subtest: timestamp-moving
[392.288570] Subtest timestamp-moving: SUCCESS (1.001s)
[392.377226] [092/133] (633s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[392.494239] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[392.498577] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[392.651104] [093/133] (633s left) sysfs_heartbeat_interval (invalid)
[392.712408] Starting subtest: invalid
[392.714729] Starting dynamic subtest: vecs0
[392.717311] Dynamic subtest vecs0: SUCCESS (0.000s)
[392.731839] Starting dynamic subtest: ccs0
[392.734079] Dynamic subtest ccs0: SUCCESS (0.000s)
[392.744671] Starting dynamic subtest: vcs0
[392.746507] Dynamic subtest vcs0: SUCCESS (0.000s)
[392.754750] Starting dynamic subtest: bcs0
[392.756620] Dynamic subtest bcs0: SUCCESS (0.000s)
[392.764750] Starting dynamic subtest: rcs0
[392.766587] Dynamic subtest rcs0: SUCCESS (0.000s)
[392.774711] Starting dynamic subtest: vcs1
[392.776593] Dynamic subtest vcs1: SUCCESS (0.000s)
[392.778397] Subtest invalid: SUCCESS (0.006s)
[392.816535] [094/133] (633s left) gem_exec_whisper (basic-queues-all)
[392.876771] Starting subtest: basic-queues-all
[404.853090] Subtest basic-queues-all: SUCCESS (11.972s)
[405.047463] [095/133] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[405.167657] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[405.172065] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[405.246331] [096/133] (621s left) api_intel_bb (delta-check)
[405.303137] Starting subtest: delta-check
[405.307480] Subtest delta-check: SUCCESS (0.006s)
[405.391101] [097/133] (620s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[405.486690] Starting subtest: pr-overlay-plane-move-continuous-sf
[405.490810] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[405.569583] [098/133] (620s left) perf_pmu (busy)
[405.612528] Starting subtest: busy
[405.614676] Starting dynamic subtest: rcs0
[406.206270] Dynamic subtest rcs0: SUCCESS (0.594s)
[406.218941] Starting dynamic subtest: bcs0
[406.771333] Dynamic subtest bcs0: SUCCESS (0.563s)
[406.782805] Starting dynamic subtest: vcs0
[407.892841] Dynamic subtest vcs0: SUCCESS (1.118s)
[407.904994] Starting dynamic subtest: vcs1
[409.876512] Dynamic subtest vcs1: SUCCESS (1.981s)
[409.888699] Starting dynamic subtest: vecs0
[411.924348] Dynamic subtest vecs0: SUCCESS (2.045s)
[411.936237] Starting dynamic subtest: ccs0
[412.489837] Dynamic subtest ccs0: SUCCESS (0.564s)
[412.492454] Subtest busy: SUCCESS (6.880s)
[412.586266] [099/133] (613s left) kms_color (invalid-gamma-lut-sizes)
[412.695933] Starting subtest: invalid-gamma-lut-sizes
[412.698186] Starting dynamic subtest: pipe-A
[412.983141] Dynamic subtest pipe-A: SUCCESS (0.287s)
[412.992400] Starting dynamic subtest: pipe-B
[412.994596] Dynamic subtest pipe-B: SUCCESS (0.000s)
[413.003086] Starting dynamic subtest: pipe-C
[413.005296] Dynamic subtest pipe-C: SUCCESS (0.000s)
[413.013679] Starting dynamic subtest: pipe-D
[413.016039] Dynamic subtest pipe-D: SUCCESS (0.000s)
[413.018197] Subtest invalid-gamma-lut-sizes: SUCCESS (0.290s)
[413.847213] [100/133] (612s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[413.964435] Starting subtest: fbc-indfb-scaledprimary
[416.900514] Subtest fbc-indfb-scaledprimary: SUCCESS (2.941s)
[418.050742] [101/133] (608s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[418.148473] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[419.270713] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.124s)
[419.397797] [102/133] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[419.493385] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[419.496859] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[419.599942] [103/133] (606s left) gem_exec_basic (basic)
[419.660426] Starting subtest: basic
[419.662268] Starting dynamic subtest: rcs0-smem
[419.663806] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[419.672689] Starting dynamic subtest: bcs0-smem
[419.674728] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[419.683150] Starting dynamic subtest: vcs0-smem
[419.684928] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[419.693227] Starting dynamic subtest: vcs1-smem
[419.695020] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[419.703382] Starting dynamic subtest: vecs0-smem
[419.705242] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[419.713456] Starting dynamic subtest: ccs0-smem
[419.715272] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[419.717059] Subtest basic: SUCCESS (0.015s)
[420.991194] [104/133] (605s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[421.103947] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[425.591907] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.491s)
[426.746290] [105/133] (599s left) kms_psr (fbc-psr-sprite-blt)
[426.839322] Starting subtest: fbc-psr-sprite-blt
[426.841574] Starting dynamic subtest: eDP-1
[426.846090] Dynamic subtest eDP-1: SKIP (0.000s)
[426.850571] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[426.926466] [106/133] (599s left) syncobj_timeline (wait-all-complex)
[426.981909] Starting subtest: wait-all-complex
[427.198643] Subtest wait-all-complex: SUCCESS (0.215s)
[427.286588] [107/133] (599s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[427.375242] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[427.377497] Starting dynamic subtest: pipe-A-eDP-1
[428.287879] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.907s)
[428.297115] Starting dynamic subtest: pipe-B-eDP-1
[429.980468] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.689s)
[429.990624] Starting dynamic subtest: pipe-C-eDP-1
[431.454736] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.473s)
[431.464877] Starting dynamic subtest: pipe-D-eDP-1
[432.994626] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.539s)
[432.996542] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.612s)
[434.186406] [108/133] (592s left) gem_mmap_wc (bad-offset)
[434.240910] Subtest bad-offset: SKIP (0.000s)
[434.310986] [109/133] (592s left) kms_hdr (static-swap)
[434.413148] Starting subtest: static-swap
[434.419952] Subtest static-swap: SKIP (0.000s)
[434.488648] [110/133] (592s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[434.584081] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[434.585953] Starting dynamic subtest: pipe-A-eDP-1
[435.917040] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.333s)
[436.193741] Starting dynamic subtest: pipe-B-eDP-1
[437.248858] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.063s)
[437.519752] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.938s)
[438.356223] [111/133] (588s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[438.462857] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[438.465099] Starting dynamic subtest: pipe-A-default-mode
[439.619557] Dynamic subtest pipe-A-default-mode: SKIP (1.154s)
[439.624106] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.156s)
[439.766123] [112/133] (587s left) kms_cursor_edge_walk (64x64-right-edge)
[439.854071] Starting subtest: 64x64-right-edge
[439.856700] Starting dynamic subtest: pipe-A-eDP-1
[443.353906] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s)
[443.363831] Starting dynamic subtest: pipe-D-eDP-1
[446.477392] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[446.479680] Subtest 64x64-right-edge: SUCCESS (6.624s)
[447.282565] [113/133] (579s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[447.383717] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[447.388166] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[447.455666] [114/133] (579s left) gem_partial_pwrite_pread (writes-after-reads-display)
[447.507305] Subtest writes-after-reads-display: SKIP (0.000s)
[447.563714] [115/133] (579s left) kms_pm_rpm (dpms-non-lpsp)
[449.083212] Starting subtest: dpms-non-lpsp
[449.088526] Subtest dpms-non-lpsp: SKIP (0.001s)
[449.824836] [116/133] (577s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[449.894785] Starting subtest: multi-wait-all-for-submit-available-signaled
[449.897106] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[450.009447] [117/133] (577s left) gem_exec_fence (syncobj-import)
[450.475891] Starting subtest: syncobj-import
[450.481790] Subtest syncobj-import: SUCCESS (0.005s)
[452.008809] [118/133] (575s left) gem_exec_nop (basic-parallel)
[452.082602] Starting subtest: basic-parallel
[467.926092] Subtest basic-parallel: SUCCESS (15.852s)
[468.154888] [119/133] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[468.245467] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[468.249811] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[468.324408] [120/133] (558s left) perf (mi-rpc)
[468.449744] Starting subtest: mi-rpc
[468.453723] Subtest mi-rpc: SKIP (0.000s)
[468.495652] [121/133] (558s left) gem_exec_schedule (preempt-other-chain)
[468.570682] Starting subtest: preempt-other-chain
[468.572809] Starting dynamic subtest: rcs0
[468.661481] Dynamic subtest rcs0: SUCCESS (0.097s)
[468.671228] Starting dynamic subtest: bcs0
[468.746069] Dynamic subtest bcs0: SUCCESS (0.083s)
[468.758866] Starting dynamic subtest: vcs0
[468.826395] Dynamic subtest vcs0: SUCCESS (0.080s)
[468.836137] Starting dynamic subtest: vcs1
[468.906875] Dynamic subtest vcs1: SUCCESS (0.079s)
[468.918839] Starting dynamic subtest: vecs0
[468.987394] Dynamic subtest vecs0: SUCCESS (0.080s)
[468.997415] Starting dynamic subtest: ccs0
[469.073921] Dynamic subtest ccs0: SUCCESS (0.085s)
[469.076269] Subtest preempt-other-chain: SUCCESS (0.510s)
[469.923823] [122/133] (557s left) kms_draw_crc (draw-method-render)
[470.022819] Starting subtest: draw-method-render
[470.024627] Starting dynamic subtest: xrgb8888-untiled
[470.265950] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[470.276177] Starting dynamic subtest: rgb565-untiled
[470.499296] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[470.508823] Starting dynamic subtest: xrgb2101010-untiled
[470.732582] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[470.741987] Starting dynamic subtest: xbgr16161616f-untiled
[470.976792] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[470.986145] Starting dynamic subtest: xrgb8888-xtiled
[471.110973] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[471.120047] Starting dynamic subtest: rgb565-xtiled
[471.232307] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[471.241589] Starting dynamic subtest: xrgb2101010-xtiled
[471.354667] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[471.364372] Starting dynamic subtest: xbgr16161616f-xtiled
[471.487855] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[471.497262] Starting dynamic subtest: xrgb8888-4tiled
[471.621437] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[471.630403] Starting dynamic subtest: rgb565-4tiled
[471.743768] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[471.755078] Starting dynamic subtest: xrgb2101010-4tiled
[471.865713] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.120s)
[471.877147] Starting dynamic subtest: xbgr16161616f-4tiled
[471.999044] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[472.001377] Subtest draw-method-render: SUCCESS (1.978s)
[472.123820] [123/133] (555s left) gem_create (hog-create)
[472.181856] Starting subtest: hog-create
[472.183574] Starting dynamic subtest: smem0
[505.876717] Dynamic subtest smem0: SUCCESS (33.695s)
[505.879604] Subtest hog-create: SUCCESS (33.697s)
[506.068580] [124/133] (521s left) kms_lease (atomic-implicit-crtc)
[506.160999] Starting subtest: atomic-implicit-crtc
[506.163295] Starting dynamic subtest: pipe-A-eDP-1
[506.175362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[506.186111] Starting dynamic subtest: pipe-B-eDP-1
[506.197707] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[506.206866] Starting dynamic subtest: pipe-C-eDP-1
[506.217640] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[506.226691] Starting dynamic subtest: pipe-D-eDP-1
[506.237354] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[506.239570] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[506.302665] [125/133] (521s left) kms_chamelium_color (ctm-red-to-blue)
[506.390377] Subtest ctm-red-to-blue: SKIP (0.000s)
[506.439018] [126/133] (521s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[506.532970] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[506.559356] Starting dynamic subtest: pipe-A-plane-0
[506.847814] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[506.858523] Starting dynamic subtest: pipe-A-plane-3
[507.092195] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[508.196207] Starting dynamic subtest: pipe-B-plane-0
[508.488079] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[508.498886] Starting dynamic subtest: pipe-B-plane-3
[508.722277] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[509.038867] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.506s)
[509.882014] [127/133] (517s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[509.975321] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[509.979710] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[511.094367] [128/133] (516s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[511.204347] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[512.294570] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s)
[512.443458] [129/133] (515s left) i915_hangman (gt-engine-hang)
[512.515350] Starting subtest: gt-engine-hang
[512.517218] Starting dynamic subtest: rcs0
[513.906690] Dynamic subtest rcs0: SUCCESS (1.389s)
[513.918834] Starting dynamic subtest: bcs0
[515.827153] Dynamic subtest bcs0: SUCCESS (1.918s)
[515.842008] Starting dynamic subtest: vcs0
[517.810060] Dynamic subtest vcs0: SUCCESS (1.980s)
[517.822482] Starting dynamic subtest: vcs1
[518.898653] Dynamic subtest vcs1: SUCCESS (1.086s)
[518.911540] Starting dynamic subtest: vecs0
[520.882451] Dynamic subtest vecs0: SUCCESS (1.981s)
[520.895393] Starting dynamic subtest: ccs0
[522.866999] Dynamic subtest ccs0: SUCCESS (1.981s)
[522.869583] Subtest gt-engine-hang: SUCCESS (10.351s)
[522.956850] [130/133] (504s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[523.012291] Starting subtest: y-tiled-ccs-to-x-tiled
[523.016799] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[523.215156] [131/133] (504s left) gem_softpin (allocator-nopin)
[523.291382] Starting subtest: allocator-nopin
[523.368238] Subtest allocator-nopin: SUCCESS (0.079s)
[523.511237] [132/133] (504s left) dmabuf_sync_file (export-wait-after-attach)
[523.561296] Starting subtest: export-wait-after-attach
[523.563275] Subtest export-wait-after-attach: SUCCESS (0.001s)
[523.619247] [133/133] (504s left) gem_exec_whisper (basic-contexts-forked)
[523.673866] Starting subtest: basic-contexts-forked
[548.295056] Subtest basic-contexts-forked: SUCCESS (24.561s)
[548.437597] 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.