[55.558578] Initializing watchdogs
[55.558626]   /dev/watchdog0
[55.572644] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[55.577094] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.579522] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.582920] [001/131] (960s left) kms_flip (nonexisting-fb)
[55.675681] Starting subtest: nonexisting-fb
[55.677801] Starting dynamic subtest: A-eDP1
[56.916547] Dynamic subtest A-eDP1: SUCCESS (1.239s)
[56.921985] Starting dynamic subtest: B-eDP1
[58.046726] Dynamic subtest B-eDP1: SUCCESS (1.130s)
[58.053142] Starting dynamic subtest: C-eDP1
[59.180446] Dynamic subtest C-eDP1: SUCCESS (1.133s)
[59.187200] Starting dynamic subtest: D-eDP1
[60.316159] Dynamic subtest D-eDP1: SUCCESS (1.135s)
[60.320590] Subtest nonexisting-fb: SUCCESS (4.645s)
[61.508209] [002/131] (954s left) gem_exec_balancer (parallel-keep-submit-fence)
[61.769213] Starting subtest: parallel-keep-submit-fence
[62.852347] Subtest parallel-keep-submit-fence: SUCCESS (1.083s)
[62.971880] [003/131] (953s left) kms_chamelium_color (gamma)
[63.055425] Subtest gamma: SKIP (0.000s)
[63.088737] [004/131] (953s left) kms_lease (lease-invalid-connector)
[63.181351] Starting subtest: lease-invalid-connector
[63.182324] Starting dynamic subtest: pipe-A-eDP-1
[63.183241] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[63.189078] Starting dynamic subtest: pipe-B-eDP-1
[63.189935] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[63.195223] Starting dynamic subtest: pipe-C-eDP-1
[63.196094] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[63.201099] Starting dynamic subtest: pipe-D-eDP-1
[63.202189] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[63.203179] Subtest lease-invalid-connector: SUCCESS (0.002s)
[63.256589] [005/131] (952s left) perf (disabled-read-error)
[63.369754] Starting subtest: disabled-read-error
[63.384805] Subtest disabled-read-error: SUCCESS (0.015s)
[63.420392] [006/131] (952s left) kms_vrr (flipline)
[63.508597] Starting subtest: flipline
[63.511269] Subtest flipline: SKIP (0.000s)
[63.583626] [007/131] (952s left) gem_exec_alignment (single)
[63.648546] Starting subtest: single
[63.652437] Subtest single: SUCCESS (0.004s)
[63.784211] [008/131] (952s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[63.875594] Starting subtest: fbc-psr-sprite-mmap-cpu
[63.876631] Starting dynamic subtest: eDP-1
[63.878450] Dynamic subtest eDP-1: SKIP (0.000s)
[63.880292] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[63.956391] [009/131] (952s left) kms_force_connector_basic (force-load-detect)
[64.031332] Starting subtest: force-load-detect
[64.033281] Subtest force-load-detect: SKIP (0.000s)
[64.154527] [010/131] (952s left) gem_exec_schedule (thriceslice)
[64.213352] Starting subtest: thriceslice
[64.214233] Starting dynamic subtest: rcs0
[64.244099] Dynamic subtest rcs0: SUCCESS (0.031s)
[64.251403] Starting dynamic subtest: bcs0
[64.273610] Dynamic subtest bcs0: SUCCESS (0.029s)
[64.280485] Starting dynamic subtest: vcs0
[64.302353] Dynamic subtest vcs0: SUCCESS (0.029s)
[64.307838] Starting dynamic subtest: vcs1
[64.330204] Dynamic subtest vcs1: SUCCESS (0.028s)
[64.335482] Starting dynamic subtest: vecs0
[64.357762] Dynamic subtest vecs0: SUCCESS (0.027s)
[64.365212] Starting dynamic subtest: ccs0
[64.385770] Dynamic subtest ccs0: SUCCESS (0.028s)
[64.386696] Subtest thriceslice: SUCCESS (0.173s)
[64.686781] [011/131] (951s left) gem_fence_thrash (bo-write-verify-x)
[64.712526] Starting subtest: bo-write-verify-x
[64.739214] Subtest bo-write-verify-x: SKIP (0.026s)
[64.799643] [012/131] (951s left) gem_eio (in-flight-contexts-10ms)
[65.010373] Starting subtest: in-flight-contexts-10ms
[78.944049] Subtest in-flight-contexts-10ms: SUCCESS (13.934s)
[79.137166] [013/131] (937s left) gem_exec_reloc (basic-cpu-active)
[79.192931] Subtest basic-cpu-active: SKIP (0.000s)
[79.264681] [014/131] (937s left) kms_universal_plane (universal-plane-sanity)
[79.349594] Starting subtest: universal-plane-sanity
[79.350609] Starting dynamic subtest: pipe-A-eDP-1
[79.966258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.616s)
[79.973324] Starting dynamic subtest: pipe-B-eDP-1
[81.227421] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.260s)
[81.234518] Starting dynamic subtest: pipe-C-eDP-1
[82.439194] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.211s)
[82.446408] Starting dynamic subtest: pipe-D-eDP-1
[83.676565] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[83.677575] Subtest universal-plane-sanity: SUCCESS (4.326s)
[84.546623] [015/131] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[84.634739] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[84.636595] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[84.741923] [016/131] (931s left) kms_flip (bo-too-big-interruptible)
[84.835761] Starting subtest: bo-too-big-interruptible
[84.837956] Starting dynamic subtest: A-eDP1
[86.105553] Dynamic subtest A-eDP1: SUCCESS (1.267s)
[86.112193] Starting dynamic subtest: B-eDP1
[87.342556] Dynamic subtest B-eDP1: SUCCESS (1.236s)
[87.350609] Starting dynamic subtest: C-eDP1
[88.573243] Dynamic subtest C-eDP1: SUCCESS (1.230s)
[88.581468] Starting dynamic subtest: D-eDP1
[89.813943] Dynamic subtest D-eDP1: SUCCESS (1.240s)
[89.816408] Subtest bo-too-big-interruptible: SUCCESS (4.979s)
[91.037792] [017/131] (925s left) gem_mmap_wc (pf-nonblock)
[91.087408] Subtest pf-nonblock: SKIP (0.000s)
[91.149882] [018/131] (925s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[91.242834] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[91.243955] Starting dynamic subtest: pipe-A-default-mode
[94.003359] Dynamic subtest pipe-A-default-mode: SUCCESS (2.759s)
[94.004363] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.760s)
[94.833729] [019/131] (921s left) gem_madvise (dontneed-after-mmap)
[94.864394] Starting subtest: dontneed-after-mmap
[94.894583] Subtest dontneed-after-mmap: SUCCESS (0.031s)
[94.992370] [020/131] (921s left) i915_drm_fdinfo (idle)
[95.028233] Starting subtest: idle
[95.029251] Starting dynamic subtest: rcs0
[95.639319] Dynamic subtest rcs0: SUCCESS (0.610s)
[95.648502] Starting dynamic subtest: bcs0
[96.145808] Dynamic subtest bcs0: SUCCESS (0.504s)
[96.154528] Starting dynamic subtest: vcs0
[96.649928] Dynamic subtest vcs0: SUCCESS (0.504s)
[96.659062] Starting dynamic subtest: vcs1
[97.154212] Dynamic subtest vcs1: SUCCESS (0.504s)
[97.161230] Starting dynamic subtest: vecs0
[97.659198] Dynamic subtest vecs0: SUCCESS (0.504s)
[97.668485] Starting dynamic subtest: ccs0
[98.162909] Dynamic subtest ccs0: SUCCESS (0.503s)
[98.164502] Subtest idle: SUCCESS (3.132s)
[98.278395] [021/131] (918s left) kms_big_fb (y-tiled-addfb)
[98.372903] Starting subtest: y-tiled-addfb
[98.375235] Subtest y-tiled-addfb: SKIP (0.000s)
[98.466613] [022/131] (918s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[98.583671] Starting subtest: cursorA-vs-flipB-atomic-transitions
[98.585444] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[98.745194] [023/131] (918s left) kms_prop_blob (blob-prop-validate)
[98.796110] Starting subtest: blob-prop-validate
[98.797074] Subtest blob-prop-validate: SUCCESS (0.000s)
[98.909226] [024/131] (917s left) api_intel_allocator (open-vm)
[98.955185] Starting subtest: open-vm
[98.959412] Subtest open-vm: SUCCESS (0.005s)
[99.076258] [025/131] (917s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[99.171010] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[99.173074] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[99.280418] [026/131] (917s left) kms_async_flips (test-time-stamp-atomic)
[99.362710] Starting subtest: test-time-stamp-atomic
[99.739629] Starting dynamic subtest: pipe-A-eDP-1
[100.534106] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.793s)
[100.902896] Starting dynamic subtest: pipe-B-eDP-1
[101.658835] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[102.035858] Starting dynamic subtest: pipe-C-eDP-1
[102.788030] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.757s)
[103.145910] Starting dynamic subtest: pipe-D-eDP-1
[103.915525] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.773s)
[103.916568] Subtest test-time-stamp-atomic: SUCCESS (4.552s)
[105.085894] [027/131] (911s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[105.127683] Starting subtest: etime-multi-wait-all-available-unsubmitted
[105.235489] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[105.325378] [028/131] (911s left) i915_module_load (reload-with-fault-injection)
[105.352639] Starting subtest: reload-with-fault-injection
[142.216491] Subtest reload-with-fault-injection: SUCCESS (36.861s)
[142.237869] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[142.239539] [029/131] (874s left) gem_exec_fence (concurrent)
[143.696505] Starting subtest: concurrent
[143.698502] Subtest concurrent: SKIP (0.000s)
[145.900086] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.i915: true
[145.900490] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[145.902519] [030/131] (871s left) i915_drm_fdinfo (isolation)
[145.940699] Starting subtest: isolation
[145.941715] Starting dynamic subtest: rcs0
[145.983530] Dynamic subtest rcs0: SKIP (0.042s)
[145.991855] Starting dynamic subtest: bcs0
[145.993757] Dynamic subtest bcs0: SKIP (0.001s)
[145.999427] Starting dynamic subtest: vcs0
[146.001387] Dynamic subtest vcs0: SKIP (0.000s)
[146.007090] Starting dynamic subtest: vcs1
[146.008777] Dynamic subtest vcs1: SKIP (0.000s)
[146.014733] Starting dynamic subtest: vecs0
[146.016491] Dynamic subtest vecs0: SKIP (0.000s)
[146.022058] Starting dynamic subtest: ccs0
[146.023821] Dynamic subtest ccs0: SKIP (0.000s)
[146.025569] Subtest isolation: SKIP (0.047s)
[146.061438] [031/131] (870s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[146.161972] Starting subtest: plane-all-transition-nonblocking-fencing
[146.162862] Starting dynamic subtest: pipe-A-eDP-1
[148.698588] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.536s)
[149.001641] Starting dynamic subtest: pipe-B-eDP-1
[152.198107] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.201s)
[152.501947] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.340s)
[153.328720] [032/131] (863s left) kms_psr (psr-primary-blt)
[153.420288] Starting subtest: psr-primary-blt
[153.421170] Starting dynamic subtest: eDP-1
[155.118569] Dynamic subtest eDP-1: SUCCESS (1.697s)
[155.119599] Subtest psr-primary-blt: SUCCESS (1.699s)
[156.002445] [033/131] (861s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[156.113238] Starting subtest: modeset-atomic-cursor-hotspot
[156.114925] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[156.274534] [034/131] (860s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[156.359691] Starting subtest: fbcpsr-tiling-4
[163.427419] Subtest fbcpsr-tiling-4: SUCCESS (7.068s)
[163.586321] [035/131] (853s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[163.973497] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[164.806179] [036/131] (852s left) i915_pm_rps (fence-order)
[164.861756] Starting subtest: fence-order
[168.312854] Subtest fence-order: SUCCESS (3.450s)
[168.371784] [037/131] (848s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[168.416863] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[168.418713] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[168.616446] [038/131] (848s left) gem_exec_params (mmapped)
[168.667076] Starting subtest: mmapped
[168.671540] Subtest mmapped: SUCCESS (0.004s)
[168.806409] [039/131] (848s left) kms_color (ctm-red-to-blue)
[168.894191] Starting subtest: ctm-red-to-blue
[168.895142] Starting dynamic subtest: pipe-A-eDP-1
[169.568824] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.674s)
[169.575651] Starting dynamic subtest: pipe-B-eDP-1
[170.905285] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.335s)
[170.911661] Starting dynamic subtest: pipe-C-eDP-1
[172.186116] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.281s)
[172.193161] Starting dynamic subtest: pipe-D-eDP-1
[173.545267] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.357s)
[173.546415] Subtest ctm-red-to-blue: SUCCESS (4.650s)
[174.367344] [040/131] (842s left) core_hotunplug (unbind-rebind)
[174.456960] Starting subtest: unbind-rebind
[180.487551] Subtest unbind-rebind: SUCCESS (6.030s)
[180.520950] [041/131] (836s left) kms_content_protection (content-type-change)
[181.967666] Starting subtest: content-type-change
[185.380799] Subtest content-type-change: SKIP (3.412s)
[186.578185] [042/131] (830s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[186.667222] Starting subtest: compare-crc-sanitycheck-nv12
[186.668144] Starting dynamic subtest: pipe-A-eDP-1
[187.330961] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.663s)
[187.338204] Starting dynamic subtest: pipe-B-eDP-1
[188.597335] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.264s)
[188.605081] Starting dynamic subtest: pipe-C-eDP-1
[189.792069] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.193s)
[189.799767] Starting dynamic subtest: pipe-D-eDP-1
[191.012261] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[191.013211] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.346s)
[191.881441] [043/131] (825s left) kms_cursor_crc (cursor-offscreen-64x64)
[192.044249] Starting subtest: cursor-offscreen-64x64
[192.047875] Starting dynamic subtest: pipe-A-eDP-1
[193.977762] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[194.003196] Starting dynamic subtest: pipe-D-eDP-1
[196.589175] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.591s)
[196.590187] Subtest cursor-offscreen-64x64: SUCCESS (4.544s)
[197.447563] [044/131] (819s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[197.541607] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[197.543495] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[197.659777] [045/131] (819s left) gem_ctx_param (invalid-set-no-zeromap)
[197.708561] Starting subtest: invalid-set-no-zeromap
[197.709678] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[197.796683] [046/131] (819s left) gem_gpgpu_fill (basic)
[197.852975] Starting subtest: basic
[197.854064] Starting dynamic subtest: smem
[197.859118] Dynamic subtest smem: SUCCESS (0.007s)
[197.860125] Subtest basic: SUCCESS (0.007s)
[198.016935] [047/131] (819s left) kms_selftest (drm_format_helper)
[198.047784] Starting subtest: drm_format_helper
[198.060892] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[198.189308] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.129s)
[198.195851] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[198.314311] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.124s)
[198.320860] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[198.446254] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.131s)
[198.453637] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[198.595037] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.149s)
[198.601508] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[198.731311] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.135s)
[198.738377] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[198.872491] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.141s)
[198.880555] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[198.998492] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.124s)
[199.006693] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[199.123480] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.124s)
[199.130461] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[199.256491] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.133s)
[199.264802] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[199.409736] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.152s)
[199.417974] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[199.525600] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.116s)
[199.532969] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[199.660468] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.134s)
[199.667154] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[199.755443] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.094s)
[199.763961] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[199.880624] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.125s)
[199.889301] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[200.002746] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.119s)
[200.010286] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[200.146807] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.144s)
[200.153725] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[200.226782] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.081s)
[200.227665] Subtest drm_format_helper: SUCCESS (2.179s)
[200.421351] [048/131] (817s left) gem_softpin (allocator-nopin)
[200.477503] Starting subtest: allocator-nopin
[200.598962] Subtest allocator-nopin: SUCCESS (0.120s)
[200.738722] [049/131] (816s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[200.835349] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[200.836224] Starting dynamic subtest: pipe-A-eDP-1
[200.844750] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[200.853166] Starting dynamic subtest: pipe-B-eDP-1
[200.862887] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[200.870556] Starting dynamic subtest: pipe-C-eDP-1
[200.879069] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[200.886110] Starting dynamic subtest: pipe-D-eDP-1
[200.894705] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[200.896376] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[203.012693] [050/131] (814s left) api_intel_bb (bb-with-allocator)
[203.068045] Starting subtest: bb-with-allocator
[203.073338] Subtest bb-with-allocator: SUCCESS (0.006s)
[203.229666] [051/131] (814s left) kms_flip (modeset-vs-vblank-race)
[203.323327] Starting subtest: modeset-vs-vblank-race
[203.325428] Starting dynamic subtest: A-eDP1
[208.034189] Dynamic subtest A-eDP1: SUCCESS (4.708s)
[208.045574] Starting dynamic subtest: B-eDP1
[212.778287] Dynamic subtest B-eDP1: SUCCESS (4.742s)
[212.794166] Starting dynamic subtest: C-eDP1
[217.392184] Dynamic subtest C-eDP1: SUCCESS (4.612s)
[217.407113] Starting dynamic subtest: D-eDP1
[222.020065] Dynamic subtest D-eDP1: SUCCESS (4.626s)
[222.022235] Subtest modeset-vs-vblank-race: SUCCESS (18.698s)
[223.194565] [052/131] (794s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[223.290012] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[226.891096] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.602s)
[228.076034] [053/131] (789s left) kms_atomic_interruptible (legacy-pageflip)
[228.170363] Starting subtest: legacy-pageflip
[228.171383] Starting dynamic subtest: pipe-A-eDP-1
[235.596798] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.426s)
[235.597939] Subtest legacy-pageflip: SUCCESS (7.427s)
[236.423529] [054/131] (781s left) kms_invalid_mode (overflow-vrefresh)
[236.510694] Starting subtest: overflow-vrefresh
[236.511637] Starting dynamic subtest: pipe-A-eDP-1
[236.789632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s)
[236.796726] Starting dynamic subtest: pipe-B-eDP-1
[236.797632] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[236.804086] Starting dynamic subtest: pipe-C-eDP-1
[236.804999] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[236.811622] Starting dynamic subtest: pipe-D-eDP-1
[236.812592] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[236.813560] Subtest overflow-vrefresh: SUCCESS (0.285s)
[237.661284] [055/131] (780s left) gem_readwrite (read-bad-handle)
[237.722526] Subtest read-bad-handle: SKIP (0.000s)
[237.791111] [056/131] (779s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[237.892091] Starting subtest: x-tiled-64bpp-rotate-180
[239.291798] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.400s)
[239.464173] [057/131] (778s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[239.553964] Starting subtest: yf-tiled-addfb-size-offset-overflow
[239.555801] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[239.654999] [058/131] (778s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[239.740817] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[239.741815] Starting dynamic subtest: pipe-A-eDP-1
[239.750698] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[239.757480] Starting dynamic subtest: pipe-B-eDP-1
[239.765950] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.772737] Starting dynamic subtest: pipe-C-eDP-1
[239.781058] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.787798] Starting dynamic subtest: pipe-D-eDP-1
[239.796198] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[239.797870] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[241.915392] [059/131] (775s left) syncobj_timeline (invalid-signal-illegal-handle)
[241.968519] Starting subtest: invalid-signal-illegal-handle
[241.969504] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[242.069253] [060/131] (775s left) gem_ctx_isolation (preservation-s3)
[242.125831] Starting subtest: preservation-S3
[242.126980] Starting dynamic subtest: rcs0
[259.160270] Dynamic subtest rcs0: SUCCESS (1.801s)
[259.171232] Starting dynamic subtest: bcs0
[276.091029] Dynamic subtest bcs0: SUCCESS (1.648s)
[276.099285] Starting dynamic subtest: vcs0
[293.086749] Dynamic subtest vcs0: SUCCESS (2.746s)
[293.095012] Starting dynamic subtest: vcs1
[311.157526] Dynamic subtest vcs1: SUCCESS (5.070s)
[311.165975] Starting dynamic subtest: vecs0
[329.144703] Dynamic subtest vecs0: SUCCESS (4.986s)
[329.152849] Starting dynamic subtest: ccs0
[347.087928] Dynamic subtest ccs0: SUCCESS (3.117s)
[347.088832] Subtest preservation-S3: SUCCESS (19.372s)
[353.342948] [061/131] (670s left) kms_pm_lpsp (screens-disabled)
[354.437029] Starting subtest: screens-disabled
[354.438742] Subtest screens-disabled: SKIP (0.000s)
[354.515916] [062/131] (669s left) gem_mmap_gtt (cpuset-big-copy-xy)
[354.569562] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[354.628913] [063/131] (669s left) core_auth (basic-auth)
[354.671708] Starting subtest: basic-auth
[354.672740] Subtest basic-auth: SUCCESS (0.001s)
[354.778670] [064/131] (669s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[354.864387] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[354.866359] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[354.977513] [065/131] (669s left) perf_pmu (busy-hang)
[355.012896] Starting subtest: busy-hang
[355.013940] Starting dynamic subtest: rcs0
[356.286808] Dynamic subtest rcs0: SUCCESS (1.272s)
[356.297206] Starting dynamic subtest: bcs0
[357.520659] Dynamic subtest bcs0: SUCCESS (1.230s)
[357.530402] Starting dynamic subtest: vcs0
[359.981475] Dynamic subtest vcs0: SUCCESS (2.459s)
[359.992153] Starting dynamic subtest: vcs1
[362.031945] Dynamic subtest vcs1: SUCCESS (2.046s)
[362.041695] Starting dynamic subtest: vecs0
[364.021893] Dynamic subtest vecs0: SUCCESS (1.988s)
[364.031551] Starting dynamic subtest: ccs0
[365.271282] Dynamic subtest ccs0: SUCCESS (1.246s)
[365.272536] Subtest busy-hang: SUCCESS (10.251s)
[365.400868] [066/131] (658s left) kms_plane_alpha_blend (coverage-7efc)
[365.493536] Starting subtest: coverage-7efc
[365.799020] Starting dynamic subtest: pipe-A-eDP-1
[366.361676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[366.385508] Starting dynamic subtest: pipe-D-eDP-1
[367.686042] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s)
[367.687210] Subtest coverage-7efc: SUCCESS (2.192s)
[368.569051] [067/131] (655s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[368.669131] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[375.757810] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.088s)
[376.949350] [068/131] (647s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[377.051583] Starting subtest: 2x-cursor-vs-flip-atomic
[377.055304] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[377.213471] [069/131] (647s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[377.302452] Starting subtest: crc-primary-suspend-y-tiled-ccs
[377.303420] Starting dynamic subtest: pipe-A-eDP-1
[377.307156] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[377.314838] Starting dynamic subtest: pipe-B-eDP-1
[377.318476] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[377.326652] Starting dynamic subtest: pipe-C-eDP-1
[377.330221] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[377.338077] Starting dynamic subtest: pipe-D-eDP-1
[377.341910] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.343594] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[379.514350] [070/131] (644s left) gem_exec_reloc (basic-wc-gtt-active)
[379.574548] Subtest basic-wc-gtt-active: SKIP (0.000s)
[379.644283] [071/131] (644s left) gem_ccs (ctrl-surf-copy-new-ctx)
[379.703532] Starting subtest: ctrl-surf-copy-new-ctx
[379.705723] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[379.819693] [072/131] (644s left) gem_lmem_swapping (parallel-random-verify)
[379.852565] Subtest parallel-random-verify: SKIP (0.000s)
[379.889717] [073/131] (644s left) gem_exec_alignment (forked)
[379.941527] Starting subtest: forked
[421.967093] Subtest forked: SUCCESS (42.019s)
[422.214335] [074/131] (602s left) gen9_exec_parse (allowed-all)
[422.293239] Subtest allowed-all: SKIP (0.000s)
[422.370652] [075/131] (602s left) kms_plane (plane-position-covered)
[422.458394] Starting subtest: plane-position-covered
[422.967638] Starting dynamic subtest: pipe-A-plane-1
[424.279792] Dynamic subtest pipe-A-plane-1: SUCCESS (1.312s)
[424.288527] Starting dynamic subtest: pipe-A-plane-2
[425.497693] Dynamic subtest pipe-A-plane-2: SUCCESS (1.216s)
[425.506875] Starting dynamic subtest: pipe-A-plane-3
[426.739060] Dynamic subtest pipe-A-plane-3: SUCCESS (1.241s)
[426.748576] Starting dynamic subtest: pipe-A-plane-4
[427.976112] Dynamic subtest pipe-A-plane-4: SUCCESS (1.236s)
[427.984970] Starting dynamic subtest: pipe-A-plane-5
[428.004869] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[429.130884] Starting dynamic subtest: pipe-B-plane-1
[430.335211] Dynamic subtest pipe-B-plane-1: SUCCESS (1.216s)
[430.345076] Starting dynamic subtest: pipe-B-plane-2
[431.577368] Dynamic subtest pipe-B-plane-2: SUCCESS (1.242s)
[431.586270] Starting dynamic subtest: pipe-B-plane-3
[432.810751] Dynamic subtest pipe-B-plane-3: SUCCESS (1.233s)
[432.819780] Starting dynamic subtest: pipe-B-plane-4
[434.038080] Dynamic subtest pipe-B-plane-4: SUCCESS (1.225s)
[434.048819] Starting dynamic subtest: pipe-B-plane-5
[434.065300] Dynamic subtest pipe-B-plane-5: SUCCESS (0.027s)
[434.066230] Subtest plane-position-covered: SUCCESS (11.606s)
[434.863055] [076/131] (589s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[434.966255] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[435.955826] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.991s)
[436.129697] [077/131] (588s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[436.227227] Starting subtest: psr-rgb101010-draw-render
[443.508735] Subtest psr-rgb101010-draw-render: SUCCESS (7.281s)
[443.674561] [078/131] (580s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[443.759569] Starting subtest: fbc-dirtyfb-ioctl
[443.760367] Starting dynamic subtest: A-eDP-1
[446.360923] Dynamic subtest A-eDP-1: SUCCESS (2.600s)
[446.361941] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.601s)
[447.173015] [079/131] (577s left) syncobj_timeline (wait-all-delayed-signal)
[447.230505] Starting subtest: wait-all-delayed-signal
[447.335124] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[447.433754] [080/131] (577s left) gem_mmap (short-mmap)
[447.489472] Subtest short-mmap: SKIP (0.000s)
[447.544431] [081/131] (577s left) kms_flip (nonexisting-fb-interruptible)
[447.635807] Starting subtest: nonexisting-fb-interruptible
[447.638008] Starting dynamic subtest: A-eDP1
[448.748644] Dynamic subtest A-eDP1: SUCCESS (1.109s)
[448.758576] Starting dynamic subtest: B-eDP1
[449.888554] Dynamic subtest B-eDP1: SUCCESS (1.140s)
[449.897743] Starting dynamic subtest: C-eDP1
[451.016990] Dynamic subtest C-eDP1: SUCCESS (1.128s)
[451.025918] Starting dynamic subtest: D-eDP1
[452.149858] Dynamic subtest D-eDP1: SUCCESS (1.132s)
[452.152624] Subtest nonexisting-fb-interruptible: SUCCESS (4.515s)
[453.332318] [082/131] (571s left) tools_test (tools_test)
[453.367465] Starting subtest: tools_test
[453.428610] Subtest tools_test: SUCCESS (0.068s)
[453.498228] [083/131] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[453.598044] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[460.303083] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.706s)
[460.434268] [084/131] (564s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[460.528142] Starting subtest: extended-pageflip-modeset-hang-oldfb
[460.529107] Starting dynamic subtest: pipe-A
[468.445075] Dynamic subtest pipe-A: SUCCESS (7.916s)
[468.455262] Starting dynamic subtest: pipe-D
[477.065637] Dynamic subtest pipe-D: SUCCESS (8.619s)
[477.066998] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.539s)
[477.929386] [085/131] (546s left) kms_psr (pr-primary-mmap-cpu)
[478.010311] Starting subtest: pr-primary-mmap-cpu
[478.012195] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[478.103515] [086/131] (546s left) gem_ctx_sseu (invalid-args)
[478.160394] Subtest invalid-args: SKIP (0.000s)
[478.243248] [087/131] (546s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[478.354516] Starting subtest: 4-tiled-16bpp-rotate-90
[478.374800] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[478.533347] [088/131] (546s left) perf (mi-rpc)
[478.661555] Starting subtest: mi-rpc
[478.663326] Subtest mi-rpc: SKIP (0.000s)
[478.702269] [089/131] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[478.783058] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[486.063229] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.281s)
[486.217421] [090/131] (538s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[486.306120] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[486.308202] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[486.418456] [091/131] (538s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[486.517727] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[487.439606] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.923s)
[487.594153] [092/131] (537s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[488.158822] Starting subtest: syncobj-timeline-multiple-ext-nodes
[488.161955] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[489.648392] [093/131] (535s left) kms_cursor_crc (cursor-sliding-512x512)
[489.931589] Starting subtest: cursor-sliding-512x512
[489.933913] Subtest cursor-sliding-512x512: SKIP (0.001s)
[490.125901] [094/131] (534s left) gem_exec_params (rsvd2-dirt)
[490.184396] Starting subtest: rsvd2-dirt
[490.186996] Subtest rsvd2-dirt: SKIP (0.000s)
[490.293537] [095/131] (534s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[490.374921] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[490.376662] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[490.489348] [096/131] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[490.579133] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[490.580732] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[490.685512] [097/131] (534s left) prime_mmap (test_refcounting)
[490.738891] Starting subtest: test_refcounting
[490.740066] Starting dynamic subtest: test_refcounting-smem
[490.769982] Dynamic subtest test_refcounting-smem: SUCCESS (0.030s)
[490.771494] Subtest test_refcounting: SUCCESS (0.031s)
[490.903171] [098/131] (534s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[491.010622] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[522.155769] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.144s)
[523.026268] [099/131] (502s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[523.116089] Starting subtest: fbc-indfb-scaledprimary
[526.132044] Subtest fbc-indfb-scaledprimary: SUCCESS (3.016s)
[527.337852] [100/131] (497s left) prime_mmap (test_forked)
[527.385498] Starting subtest: test_forked
[527.386509] Starting dynamic subtest: test_forked-smem
[527.423707] Dynamic subtest test_forked-smem: SUCCESS (0.039s)
[527.425099] Subtest test_forked: SUCCESS (0.040s)
[527.554989] [101/131] (497s left) gem_workarounds (basic-read-context)
[527.621755] Starting subtest: basic-read-context
[527.637557] Subtest basic-read-context: SUCCESS (0.016s)
[527.787503] [102/131] (497s left) gem_exec_params (rel-constants-invalid-ring)
[527.837412] Starting subtest: rel-constants-invalid-ring
[527.838407] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[527.972008] [103/131] (497s left) gem_caching (read-writes)
[528.030095] Subtest read-writes: SKIP (0.000s)
[528.092528] [104/131] (497s left) gem_pxp (fail-invalid-protected-context)
[528.205835] Starting subtest: fail-invalid-protected-context
[528.206915] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[528.334502] [105/131] (497s left) kms_psr (fbc-pr-no-drrs)
[528.428074] Starting subtest: fbc-pr-no-drrs
[528.430352] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[528.503830] [106/131] (496s left) gem_userptr_blits (userfault)
[528.557291] Starting subtest: userfault
[528.561701] Subtest userfault: SUCCESS (0.006s)
[528.723518] [107/131] (496s left) gem_barrier_race (remote-request)
[528.780825] Starting subtest: remote-request
[528.781926] Starting dynamic subtest: rcs0
[533.933297] Dynamic subtest rcs0: SUCCESS (5.152s)
[533.934564] Subtest remote-request: SUCCESS (5.152s)
[534.072577] [108/131] (491s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[534.162205] Starting subtest: random-ccs-data-yf-tiled-ccs
[534.163381] Starting dynamic subtest: pipe-A-eDP-1
[534.174215] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[534.183540] Starting dynamic subtest: pipe-B-eDP-1
[534.194091] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[534.204865] Starting dynamic subtest: pipe-C-eDP-1
[534.215237] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[534.223857] Starting dynamic subtest: pipe-D-eDP-1
[534.233271] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[534.234910] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[536.297831] [109/131] (489s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[536.392381] Starting subtest: psr-1p-primscrn-spr-indfb-move
[543.750768] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.358s)
[543.904469] [110/131] (481s left) gem_flink_basic (flink-lifetime)
[543.952394] Starting subtest: flink-lifetime
[543.954680] Subtest flink-lifetime: SUCCESS (0.002s)
[544.093020] [111/131] (481s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[549.103626] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[549.106235] Starting dynamic subtest: pipe-A-eDP-1
[555.726993] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.620s)
[555.735701] Starting dynamic subtest: pipe-B-eDP-1
[562.391677] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.663s)
[562.392698] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.287s)
[563.291445] [112/131] (462s left) gem_exec_schedule (semaphore-power)
[563.480695] Subtest semaphore-power: SKIP (0.000s)
[563.684896] [113/131] (462s left) perf_pmu (module-unload)
[563.758075] Starting subtest: module-unload
[570.632059] Subtest module-unload: FAIL (6.840s)
[570.654291] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[570.655041] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[570.657557] [114/131] (455s left) i915_suspend (fence-restore-untiled)
[572.259555] Starting subtest: fence-restore-untiled
[572.261746] Subtest fence-restore-untiled: SKIP (0.000s)
[572.302141] [FACT i915_suspend (fence-restore-untiled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[572.303384] [FACT i915_suspend (fence-restore-untiled)] new: kernel.kmod_is_loaded.i915: true
[572.306469] [115/131] (453s left) kms_psr (fbc-psr2-cursor-plane-move)
[572.400458] Starting subtest: fbc-psr2-cursor-plane-move
[572.401445] Starting dynamic subtest: eDP-1
[572.403416] Dynamic subtest eDP-1: SKIP (0.000s)
[572.405137] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[572.477349] [116/131] (453s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[572.574999] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[572.576691] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[572.694438] [117/131] (453s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[577.705133] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[577.707555] Starting dynamic subtest: pipe-A-eDP-1
[578.506833] Dynamic subtest pipe-A-eDP-1: SKIP (0.799s)
[578.514844] Starting dynamic subtest: pipe-B-eDP-1
[579.641776] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[579.643747] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.935s)
[580.839456] [118/131] (445s left) sw_sync (sync_busy)
[580.869369] Starting subtest: sync_busy
[580.870259] Subtest sync_busy: SUCCESS (0.002s)
[580.947705] [119/131] (444s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[581.009127] Starting subtest: multi-wait-available-unsubmitted-submitted
[581.010693] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[581.133923] [120/131] (444s left) sriov_basic (enable-vfs-bind-unbind-each)
[581.189183] Starting subtest: enable-vfs-bind-unbind-each
[581.190502] Starting dynamic subtest: numvfs-1
[581.222102] Dynamic subtest numvfs-1: FAIL (0.005s)
[581.230084] Starting dynamic subtest: numvfs-2
[581.259948] Dynamic subtest numvfs-2: FAIL (0.003s)
[581.267086] Starting dynamic subtest: numvfs-3
[581.293139] Dynamic subtest numvfs-3: FAIL (0.004s)
[581.299831] Starting dynamic subtest: numvfs-4
[581.325242] Dynamic subtest numvfs-4: FAIL (0.003s)
[581.332411] Starting dynamic subtest: numvfs-5
[581.360797] Dynamic subtest numvfs-5: FAIL (0.004s)
[581.367879] Starting dynamic subtest: numvfs-6
[581.396018] Dynamic subtest numvfs-6: FAIL (0.003s)
[581.403778] Starting dynamic subtest: numvfs-7
[581.431484] Dynamic subtest numvfs-7: FAIL (0.004s)
[581.438493] Starting dynamic subtest: numvfs-random
[581.466219] Dynamic subtest numvfs-random: FAIL (0.004s)
[581.467051] Subtest enable-vfs-bind-unbind-each: FAIL (0.034s)
[581.495358] [121/131] (444s left) gem_exec_reloc (basic-cpu-read-active)
[581.560321] Subtest basic-cpu-read-active: SKIP (0.000s)
[581.642223] [122/131] (444s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[581.735919] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[588.585598] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.851s)
[588.740556] [123/131] (437s left) kms_addfb_basic (unused-modifier)
[588.792658] Starting subtest: unused-modifier
[588.793831] Subtest unused-modifier: SUCCESS (0.000s)
[588.945243] [124/131] (437s left) gem_softpin (evict-active)
[588.999882] Starting subtest: evict-active
[589.010602] Subtest evict-active: SUCCESS (0.011s)
[589.172787] [125/131] (436s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[589.249381] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[589.250353] Starting dynamic subtest: pipe-A-default-mode
[589.608411] Dynamic subtest pipe-A-default-mode: SKIP (0.358s)
[589.610390] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.359s)
[590.399957] [126/131] (435s left) vgem_basic (bad-flag)
[590.435244] Starting subtest: bad-flag
[590.436539] Subtest bad-flag: SUCCESS (0.000s)
[590.499667] [127/131] (435s left) kms_feature_discovery (chamelium)
[590.598404] Starting subtest: chamelium
[590.600052] Subtest chamelium: SKIP (0.000s)
[590.678945] [128/131] (435s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[590.789086] Starting subtest: cursorB-vs-flipA-toggle
[590.791828] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[590.950328] [129/131] (435s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[591.046508] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[597.690107] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.645s)
[597.844032] [130/131] (428s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[597.897731] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[597.999500] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[598.083942] [131/131] (428s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[598.169526] Starting subtest: plane-upscale-factor-0-25-with-rotation
[598.170455] Starting dynamic subtest: pipe-A
[598.395336] Dynamic subtest pipe-A: SUCCESS (0.227s)
[598.403191] Starting dynamic subtest: pipe-B
[599.722517] Dynamic subtest pipe-B: SUCCESS (1.327s)
[599.730543] Starting dynamic subtest: pipe-C
[601.055627] Dynamic subtest pipe-C: SUCCESS (1.333s)
[601.063225] Starting dynamic subtest: pipe-D
[602.387797] Dynamic subtest pipe-D: SUCCESS (1.331s)
[602.389048] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.220s)
[603.591007] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: kms_chamelium_color
results: parsing output: 3/ for test: kms_lease
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: kms_vrr
results: parsing output: 6/ for test: gem_exec_alignment
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_force_connector_basic
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: gem_fence_thrash
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_universal_plane
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_mmap_wc
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: gem_madvise
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: kms_prop_blob
results: parsing output: 23/ for test: api_intel_allocator
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: i915_module_load
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: kms_atomic_transition
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_chamelium_frames
results: parsing output: 35/ for test: i915_pm_rps
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_color
results: parsing output: 39/ for test: core_hotunplug
results: parsing output: 40/ for test: kms_content_protection
results: parsing output: 41/ for test: kms_pipe_crc_basic
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_ctx_param
results: parsing output: 45/ for test: gem_gpgpu_fill
results: parsing output: 46/ for test: kms_selftest
results: parsing output: 47/ for test: gem_softpin
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: kms_invalid_mode
results: parsing output: 54/ for test: gem_readwrite
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_ctx_isolation
results: parsing output: 60/ for test: kms_pm_lpsp
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: core_auth
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: gem_ccs
results: parsing output: 71/ for test: gem_lmem_swapping
results: parsing output: 72/ for test: gem_exec_alignment
results: parsing output: 73/ for test: gen9_exec_parse
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_dirtyfb
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_mmap
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: tools_test
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_ctx_sseu
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: prime_mmap
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: prime_mmap
results: parsing output: 100/ for test: gem_workarounds
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: gem_caching
results: parsing output: 103/ for test: gem_pxp
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: gem_barrier_race
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_flink_basic
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: sw_sync
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: sriov_basic
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: gem_softpin
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: kms_feature_discovery
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_plane_scaling
Done.